You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/11/17 15:59:44 UTC
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1536 - Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1536/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseSerialGC
4 tests failed.
FAILED: org.apache.solr.cloud.AliasIntegrationTest.test
Error Message:
Collection not found: testalias2
Stack Trace:
org.apache.solr.common.SolrException: Collection not found: testalias2
at __randomizedtesting.SeedInfo.seed([A1B5921476E9E81A:29E1ADCED81585E2]:0)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:850)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at org.apache.solr.client.solrj.SolrClient.query(SolrClient.java:942)
at org.apache.solr.cloud.AliasIntegrationTest.searchSeveralWays(AliasIntegrationTest.java:267)
at org.apache.solr.cloud.AliasIntegrationTest.searchSeveralWays(AliasIntegrationTest.java:261)
at org.apache.solr.cloud.AliasIntegrationTest.test(AliasIntegrationTest.java:226)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingSorting
Error Message:
Should have exactly 4 documents returned expected:<4> but was:<2>
Stack Trace:
java.lang.AssertionError: Should have exactly 4 documents returned expected:<4> but was:<2>
at __randomizedtesting.SeedInfo.seed([A1B5921476E9E81A:BF8D9A1C0A42529A]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.cloud.DocValuesNotIndexedTest.checkSortOrder(DocValuesNotIndexedTest.java:260)
at org.apache.solr.cloud.DocValuesNotIndexedTest.testGroupingSorting(DocValuesNotIndexedTest.java:245)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication
Error Message:
Index: 0, Size: 0
Stack Trace:
java.lang.IndexOutOfBoundsException: Index: 0, Size: 0
at __randomizedtesting.SeedInfo.seed([A1B5921476E9E81A:B5FDC94155EE5504]:0)
at java.util.ArrayList.rangeCheck(ArrayList.java:657)
at java.util.ArrayList.get(ArrayList.java:433)
at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:561)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
FAILED: org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest.test
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at __randomizedtesting.SeedInfo.seed([A1B5921476E9E81A:29E1ADCED81585E2]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest.assertInvariants(TimePartitionedUpdateProcessorTest.java:245)
at org.apache.solr.update.processor.TimePartitionedUpdateProcessorTest.test(TimePartitionedUpdateProcessorTest.java:123)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 11632 lines...]
[junit4] Suite: org.apache.solr.cloud.AliasIntegrationTest
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/init-core-data-001
[junit4] 2> 140920 WARN (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 140920 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 140921 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 140921 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 140922 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001
[junit4] 2> 140922 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 140922 INFO (Thread-83) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 140922 INFO (Thread-83) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 140928 ERROR (Thread-83) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 141027 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:41757
[junit4] 2> 141086 INFO (jetty-launcher-106-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 141088 INFO (jetty-launcher-106-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4595561e{/solr,null,AVAILABLE}
[junit4] 2> 141094 INFO (jetty-launcher-106-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 141094 INFO (jetty-launcher-106-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@51944bdb{HTTP/1.1,[http/1.1]}{127.0.0.1:52261}
[junit4] 2> 141094 INFO (jetty-launcher-106-thread-2) [ ] o.e.j.s.Server Started @143104ms
[junit4] 2> 141095 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=52261}
[junit4] 2> 141095 INFO (jetty-launcher-106-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@42dc2ab3{/solr,null,AVAILABLE}
[junit4] 2> 141095 ERROR (jetty-launcher-106-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 141095 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 141095 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-17T14:30:35.707Z
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2d97c95f{HTTP/1.1,[http/1.1]}{127.0.0.1:46054}
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.e.j.s.Server Started @143106ms
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46054}
[junit4] 2> 141096 ERROR (jetty-launcher-106-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.0.0
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 141096 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-17T14:30:35.707Z
[junit4] 2> 141129 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 141129 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 141141 INFO (jetty-launcher-106-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41757/solr
[junit4] 2> 141151 INFO (jetty-launcher-106-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41757/solr
[junit4] 2> 141238 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 141239 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46054_solr
[junit4] 2> 141240 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.c.Overseer Overseer (id=99020245272887302-127.0.0.1:46054_solr-n_0000000000) starting
[junit4] 2> 141249 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46054_solr
[junit4] 2> 141301 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 141329 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 141335 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 141340 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52261_solr
[junit4] 2> 141345 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 141345 INFO (zkCallback-117-thread-1-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 141474 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52261.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141502 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46054.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141502 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52261.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141502 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52261.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141504 INFO (jetty-launcher-106-thread-2) [n:127.0.0.1:52261_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node2/.
[junit4] 2> 141513 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46054.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141513 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46054.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 141516 INFO (jetty-launcher-106-thread-1) [n:127.0.0.1:46054_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node1/.
[junit4] 2> 141584 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 141585 INFO (SUITE-AliasIntegrationTest-seed#[A1B5921476E9E81A]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41757/solr ready
[junit4] 2> 141819 INFO (TEST-AliasIntegrationTest.test-seed#[A1B5921476E9E81A]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 141832 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 141836 INFO (OverseerThreadFactory-151-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 141951 INFO (OverseerStateUpdate-99020245272887302-127.0.0.1:46054_solr-n_0000000000) [n:127.0.0.1:46054_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:46054/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 141955 INFO (OverseerStateUpdate-99020245272887302-127.0.0.1:46054_solr-n_0000000000) [n:127.0.0.1:46054_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:52261/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 142169 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 142178 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 142190 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 142190 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 142311 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 142313 INFO (zkCallback-117-thread-2-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 142314 INFO (zkCallback-118-thread-2-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 142316 INFO (zkCallback-117-thread-1-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143225 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 143226 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 143245 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=minimal
[junit4] 2> 143245 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=minimal
[junit4] 2> 143256 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 143256 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true
[junit4] 2> 143256 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46054.solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 143256 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 143257 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node1/collection1_shard1_replica_n1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
[junit4] 2> 143257 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 143257 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using configuration from collection collection1, trusted=true
[junit4] 2> 143257 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_52261.solr.core.collection1.shard2.replica_n2' (registry 'solr.core.collection1.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 143257 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 143258 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node2/collection1_shard2_replica_n2], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node2/./collection1_shard2_replica_n2/data/]
[junit4] 2> 143304 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 143304 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 143305 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 143305 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 143306 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7eb918d8[collection1_shard1_replica_n1] main]
[junit4] 2> 143311 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 143311 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 143311 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 143311 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584323926868099072
[junit4] 2> 143319 INFO (searcherExecutor-156-thread-1-processing-n:127.0.0.1:46054_solr x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@7eb918d8[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 143327 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 143346 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/ shard1
[junit4] 2> 143377 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 143377 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 143378 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 143378 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 143381 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@2a4e0aac[collection1_shard2_replica_n2] main]
[junit4] 2> 143382 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 143382 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 143383 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 143387 INFO (searcherExecutor-157-thread-1-processing-n:127.0.0.1:52261_solr x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@2a4e0aac[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 143388 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584323926947790848
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/ has no replicas
[junit4] 2> 143393 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 143399 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/ shard2
[junit4] 2> 143506 INFO (zkCallback-118-thread-2-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143506 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143508 INFO (zkCallback-117-thread-1-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143510 INFO (zkCallback-117-thread-2-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143510 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 143517 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1327
[junit4] 2> 143549 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 143551 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1382
[junit4] 2> 143568 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 143663 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143663 INFO (zkCallback-118-thread-3-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143663 INFO (zkCallback-117-thread-1-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143663 INFO (zkCallback-117-thread-2-processing-n:127.0.0.1:52261_solr) [n:127.0.0.1:52261_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [2])
[junit4] 2> 143838 INFO (OverseerCollectionConfigSetProcessor-99020245272887302-127.0.0.1:46054_solr-n_0000000000) [n:127.0.0.1:46054_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 144569 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2} status=0 QTime=2737
[junit4] 2> 144571 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params replicationFactor=1&collection.configName=conf&name=collection2&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 144578 INFO (OverseerThreadFactory-151-thread-2-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.CreateCollectionCmd Create collection collection2
[junit4] 2> 144789 INFO (OverseerStateUpdate-99020245272887302-127.0.0.1:46054_solr-n_0000000000) [n:127.0.0.1:46054_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection2",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection2_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:46054/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 144993 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 145105 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 145105 INFO (zkCallback-118-thread-3-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 146024 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 146055 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.s.IndexSchema [collection2_shard1_replica_n1] Schema name=minimal
[junit4] 2> 146057 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 146058 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'collection2_shard1_replica_n1' using configuration from collection collection2, trusted=true
[junit4] 2> 146058 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46054.solr.core.collection2.shard1.replica_n1' (registry 'solr.core.collection2.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30eb3d2c
[junit4] 2> 146069 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 146069 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SolrCore [[collection2_shard1_replica_n1] ] Opening new SolrCore at [/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node1/collection2_shard1_replica_n1], dataDir=[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.AliasIntegrationTest_A1B5921476E9E81A-001/tempDir-001/node1/./collection2_shard1_replica_n1/data/]
[junit4] 2> 146114 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 146114 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 146115 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 146115 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 146116 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6623924d[collection2_shard1_replica_n1] main]
[junit4] 2> 146118 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 146119 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 146120 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 146120 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1584323929813549056
[junit4] 2> 146123 INFO (searcherExecutor-166-thread-1-processing-n:127.0.0.1:46054_solr x:collection2_shard1_replica_n1 s:shard1 c:collection2 r:core_node2) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SolrCore [collection2_shard1_replica_n1] Registered new searcher Searcher@6623924d[collection2_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 146130 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 146130 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 146130 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/
[junit4] 2> 146131 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 146131 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/ has no replicas
[junit4] 2> 146131 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR
[junit4] 2> 146135 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/ shard1
[junit4] 2> 146239 INFO (zkCallback-118-thread-3-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 146239 INFO (zkCallback-118-thread-1-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 146287 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 146291 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection2_shard1_replica_n1&action=CREATE&numShards=1&collection=collection2&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=1298
[junit4] 2> 146301 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 30 seconds. Check all shard replicas
[junit4] 2> 146393 INFO (zkCallback-118-thread-3-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 146393 INFO (zkCallback-118-thread-2-processing-n:127.0.0.1:46054_solr) [n:127.0.0.1:46054_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection2/state.json] for collection [collection2] has occurred - updating... (live nodes size: [2])
[junit4] 2> 146581 INFO (OverseerCollectionConfigSetProcessor-99020245272887302-127.0.0.1:46054_solr-n_0000000000) [n:127.0.0.1:46054_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 147307 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={replicationFactor=1&collection.configName=conf&name=collection2&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2736
[junit4] 2> 147343 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[8 (1584323931076034560)]} 0 21
[junit4] 2> 147362 INFO (qtp390391517-1430) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[6 (1584323931097006080), 7 (1584323931115880448)]} 0 22
[junit4] 2> 147381 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584323931135803392,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 147381 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@387ce279 commitCommandVersion:1584323931135803392
[junit4] 2> 147385 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584323931139997696,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 147385 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5b72f533 commitCommandVersion:1584323931139997696
[junit4] 2> 147426 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@32054ef6[collection1_shard2_replica_n2] main]
[junit4] 2> 147426 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fda0969[collection1_shard1_replica_n1] main]
[junit4] 2> 147434 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 147434 INFO (searcherExecutor-156-thread-1-processing-n:127.0.0.1:46054_solr x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@7fda0969[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C1)))}
[junit4] 2> 147434 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 49
[junit4] 2> 147435 INFO (searcherExecutor-157-thread-1-processing-n:127.0.0.1:52261_solr x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher Searcher@32054ef6[collection1_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C2)))}
[junit4] 2> 147441 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 147441 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=} 0 60
[junit4] 2> 147448 INFO (qtp390391517-1431) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2] webapp=/solr path=/update params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{commit=} 0 81
[junit4] 2> 147470 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection2:4&wt=javabin&version=2}{add=[9 (1584323931211300864), 10 (1584323931229126656)]} 0 20
[junit4] 2> 147472 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 start commit{_version_=1584323931231223808,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 147472 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@5d0eb2f4 commitCommandVersion:1584323931231223808
[junit4] 2> 147498 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@53a4d1ab[collection2_shard1_replica_n1] main]
[junit4] 2> 147500 INFO (searcherExecutor-166-thread-1-processing-n:127.0.0.1:46054_solr x:collection2_shard1_replica_n1 s:shard1 c:collection2 r:core_node2) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.SolrCore [collection2_shard1_replica_n1] Registered new searcher Searcher@53a4d1ab[collection2_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C2)))}
[junit4] 2> 147505 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 147505 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.u.p.LogUpdateProcessorFactory [collection2_shard1_replica_n1] webapp=/solr path=/update params={_stateVer_=collection2:4&commit=true&wt=javabin&version=2}{commit=} 0 33
[junit4] 2> 147509 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :createalias with params collections=collection1&name=testalias&action=CREATEALIAS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 147528 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collections=collection1&name=testalias&action=CREATEALIAS&wt=javabin&version=2} status=0 QTime=19
[junit4] 2> 147531 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :listaliases with params action=LISTALIASES&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 147531 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={action=LISTALIASES&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147538 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042144&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147541 INFO (qtp390391517-1439) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042144&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147543 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042144&ids=8&isShard=true&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147543 INFO (qtp390391517-1438) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042144&ids=6,7&isShard=true&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147547 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4&wt=javabin&version=2} hits=3 status=0 QTime=13
[junit4] 2> 147559 INFO (qtp390391517-1433) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042161&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147560 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042161&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147564 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042161&ids=8&isShard=true&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147564 INFO (qtp390391517-1430) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042161&ids=6,7&isShard=true&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147565 INFO (qtp390391517-1435) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4&wt=javabin&version=2} hits=3 status=0 QTime=14
[junit4] 2> 147567 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042177&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147569 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042177&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147571 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042177&ids=8&isShard=true&collection=collection1&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147572 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042177&ids=6,7&isShard=true&collection=collection1&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147573 INFO (qtp390391517-1429) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4&collection=testalias&wt=javabin&version=2} hits=3 status=0 QTime=6
[junit4] 2> 147589 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042199&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147589 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042199&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147591 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042199&ids=8&isShard=true&collection=collection1&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147591 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4&shards.purpose=64&NOW=1510929042199&ids=6,7&isShard=true&collection=collection1&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147592 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4&collection=testalias&wt=javabin&version=2} hits=3 status=0 QTime=4
[junit4] 2> 147606 INFO (TEST-AliasIntegrationTest.test-seed#[A1B5921476E9E81A]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 147607 INFO (TEST-AliasIntegrationTest.test-seed#[A1B5921476E9E81A]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41757/solr ready
[junit4] 2> 147614 INFO (qtp390391517-1433) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042221&isShard=true&wt=javabin} hits=2 status=0 QTime=2
[junit4] 2> 147614 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042221&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147616 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042221&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147618 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042221&ids=9,10&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147619 INFO (qtp390391517-1430) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042221&ids=6,7&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147627 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042221&ids=8&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147627 INFO (qtp390391517-1440) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4|collection2:4&wt=javabin&version=2} hits=5 status=0 QTime=17
[junit4] 2> 147636 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042245&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147638 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042245&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147639 INFO (qtp390391517-1431) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042245&isShard=true&wt=javabin} hits=2 status=0 QTime=2
[junit4] 2> 147645 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042245&ids=9,10&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147645 INFO (qtp390391517-1439) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042245&ids=6,7&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 147646 INFO (qtp473442980-1443) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042245&ids=8&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147646 INFO (qtp473442980-1448) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4|collection2:4&wt=javabin&version=2} hits=5 status=0 QTime=12
[junit4] 2> 147651 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042259&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147651 INFO (qtp390391517-1438) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042259&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147652 INFO (qtp473442980-1446) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042259&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147654 INFO (qtp390391517-1433) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042259&ids=6,7&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147655 INFO (qtp473442980-1445) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042259&ids=9,10&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147656 INFO (qtp473442980-1444) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042259&ids=8&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147656 INFO (qtp390391517-1432) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={q=*:*&_stateVer_=collection1:4|collection2:4&collection=testalias,collection2&wt=javabin&version=2} hits=5 status=0 QTime=8
[junit4] 2> 147663 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2 x:collection2_shard1_replica_n1] o.a.s.c.S.Request [collection2_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection2_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042270&isShard=true&wt=javabin} hits=2 status=0 QTime=0
[junit4] 2> 147663 INFO (qtp473442980-1441) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=*:*&NOW=1510929042270&isShard=true&wt=javabin} hits=1 status=0 QTime=0
[junit4] 2> 147664 INFO (qtp390391517-1430) [n:127.0.0.1:52261_solr c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] o.a.s.c.S.Request [collection1_shard2_replica_n2] webapp=/solr path=/select params={df=text&distrib=false&_stateVer_=collection1:4|collection2:4&fl=id&fl=score&shards.purpose=4&start=0&fsv=true&collection=collection1,collection2&shard.url=http://127.0.0.1:52261/solr/collection1_shard2_replica_n2/&rows=10&version=2&q=*:*&NOW=1510929042270&isShard=true&wt=javabin} hits=2 status=0 QTime=1
[junit4] 2> 147666 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select params={q=*:*&df=text&distrib=false&_stateVer_=collection1:4|collection2:4&shards.purpose=64&NOW=1510929042270&ids=8&isShard=true&collection=collection1,collection2&shard.url=http://127.0.0.1:46054/solr/collection1_shard1_replica_n1/&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 147667 INFO (qtp473442980-1447) [n:127.0.0.1:46054_solr c:collection2 s:shard1 r:core_node2
[...truncated too long message...]
ove limit:
[junit4] 2>
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 4 /solr/configs/timeConfig
[junit4] 2> 3 /solr/configs/timeConfig/managed-schema
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/collections/timeConfig/state.json
[junit4] 2> 5 /solr/collections/myalias_2017-10-23/state.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 4 /solr/live_nodes
[junit4] 2> 4 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.update.processor.TimePartitionedUpdateProcessorTest_A1B5921476E9E81A-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1777, maxMBSortInHeap=7.313832985602777, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@16a5710a), locale=id, timezone=America/Yellowknife
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=3,threads=1,free=234615736,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestClusterStateMutator, AssignTest, TestSolrCloudWithDelegationTokens, HdfsSyncSliceTest, TestDownShardTolerantSearch, DistributedFacetPivotSmallAdvancedTest, TestFastLRUCache, AnalyticsQueryTest, StatelessScriptUpdateProcessorFactoryTest, CurrencyFieldTypeTest, TestQueryTypes, AliasIntegrationTest, FieldMutatingUpdateProcessorTest, SpellCheckCollatorWithCollapseTest, TestInPlaceUpdatesStandalone, HealthCheckHandlerTest, LargeFieldTest, TestConfigOverlay, TestNumericTerms64, TestCloudDeleteByQuery, AddBlockUpdateTest, RollingRestartTest, TestSearcherReuse, TestXmlQParserPlugin, TestTestInjection, TestSegmentSorting, ConnectionManagerTest, TestClassicSimilarityFactory, TestGroupingSearch, TestRandomRequestDistribution, TestValueSourceCache, TestManagedSchemaAPI, TestFastOutputStream, UninvertDocValuesMergePolicyTest, DistributedQueryComponentOptimizationTest, CollectionsAPIDistributedZkTest, BJQParserTest, DOMUtilTest, MigrateRouteKeyTest, TestBulkSchemaConcurrent, ExternalFileFieldSortTest, TestNestedDocsSort, TestSimpleTrackingShardHandler, TestQueryWrapperFilter, ParsingFieldUpdateProcessorsTest, TestSolrCloudWithSecureImpersonation, SearchRateTriggerTest, DeleteReplicaTest, ShardRoutingCustomTest, TestSuggestSpellingConverter, DistributedFacetPivotLargeTest, PolyFieldTest, TestAnalyzedSuggestions, TestSolrConfigHandlerCloud, TestTrie, SolrMetricReporterTest, TestCoreAdminApis, MoveReplicaTest, TestBadConfig, SolrCoreCheckLockOnStartupTest, TestRandomFaceting, DistribDocExpirationUpdateProcessorTest, SpellPossibilityIteratorTest, TriLevelCompositeIdRoutingTest, HdfsAutoAddReplicasIntegrationTest, SolrCLIZkUtilsTest, TestPostingsSolrHighlighter, TestConfig, RemoteQueryErrorTest, SparseHLLTest, DistributedQueueTest, CdcrBootstrapTest, TestElisionMultitermQuery, TestScoreJoinQPScore, ZkNodePropsTest, TestExactStatsCache, CloudExitableDirectoryReaderTest, TestShardHandlerFactory, SuggestComponentTest, ClassificationUpdateProcessorFactoryTest, DocumentBuilderTest, NodeAddedTriggerTest, TestDistribIDF, TestFieldCollectionResource, SecurityConfHandlerTest, CloudMLTQParserTest, ComputePlanActionTest, RequestLoggingTest, JavabinLoaderTest, BlockCacheTest, TestBinaryResponseWriter, TestPointFields, TestStressReorder, ReplicaListTransformerTest, TestSolrCoreParser, TestUnifiedSolrHighlighter, TestTolerantUpdateProcessorRandomCloud, ManagedSchemaRoundRobinCloudTest, TestCollectionAPI, TestBM25SimilarityFactory, TestLegacyFieldCache, PeerSyncReplicationTest, SynonymTokenizerTest, TestZkAclsWithHadoopAuth, HdfsTlogReplayBufferedWhileIndexingTest, TestZkChroot, TestMissingGroups, FileUtilsTest, TestLocalFSCloudBackupRestore, TestPKIAuthenticationPlugin, TestEmbeddedSolrServerConstructors, PeerSyncWithIndexFingerprintCachingTest, TestLMJelinekMercerSimilarityFactory, ZkStateWriterTest, TestPullReplicaErrorHandling, TestDynamicFieldCollectionResource, CoreAdminCreateDiscoverTest, CachingDirectoryFactoryTest, SharedFSAutoReplicaFailoverTest, PluginInfoTest, CdcrVersionReplicationTest, StatsReloadRaceTest, TestGraphMLResponseWriter, TestSubQueryTransformer, TestHashPartitioner, TestConfigSetsAPI, DistributedIntervalFacetingTest, CollectionsAPIAsyncDistributedZkTest, LeaderInitiatedRecoveryOnShardRestartTest, TestSystemIdResolver, TestRawTransformer, TestPrepRecovery, TestCloudSearcherWarming, TestDistributedMissingSort, TestSystemCollAutoCreate, TestFieldCacheSort, TestMergePolicyConfig, OverseerStatusTest, TestRemoteStreaming, TestSolrDeletionPolicy1, CdcrReplicationHandlerTest, TestCloudPseudoReturnFields, MetricsHandlerTest, TestStandardQParsers, TestExpandComponent, DocValuesMultiTest, TestCorePropertiesReload, TestExtendedDismaxParser, CheckHdfsIndexTest, SearchHandlerTest, TestDeleteCollectionOnDownNodes, BasicZkTest, EchoParamsTest, TestPivotHelperCode, CollectionStateFormat2Test, QueryElevationComponentTest, TestManagedResourceStorage, SubstringBytesRefFilterTest, GraphQueryTest, TestSearchPerf, TestPerFieldSimilarity, TestComplexPhraseLeadingWildcard, TestDistributedGrouping, TestWordDelimiterFilterFactory, BlobRepositoryCloudTest, TestLegacyTerms, TestManagedSynonymGraphFilterFactory, PingRequestHandlerTest, TestConfigSetsAPIZkFailure, TestPushWriter, TestHalfAndHalfDocValues, TestRTGBase, TestHdfsCloudBackupRestore, ActionThrottleTest, TestBulkSchemaAPI, PKIAuthenticationIntegrationTest, TestNRTOpen, TestCloudSchemaless, TestReload, TestSolrIndexConfig, SoftAutoCommitTest, SolrCoreTest, TestHdfsUpdateLog, BasicDistributedZk2Test, SyncSliceTest, FullSolrCloudDistribCmdsTest, ZkSolrClientTest, TestDistributedSearch, TestFaceting, DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest, ZkControllerTest, TestCoreContainer, StatsComponentTest, ConvertedLegacyTest, TestSort, TestFunctionQuery, TestIndexSearcher, AnalysisAfterCoreReloadTest, SignatureUpdateProcessorFactoryTest, SpellCheckCollatorTest, SolrRequestParserTest, TestFoldingMultitermQuery, DocValuesTest, TestQueryUtils, DirectSolrSpellCheckerTest, FileBasedSpellCheckerTest, XmlUpdateRequestHandlerTest, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, FieldAnalysisRequestHandlerTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, IndexSchemaTest, UpdateRequestProcessorFactoryTest, QueryParsingTest, UniqFieldsUpdateProcessorFactoryTest, JsonLoaderTest, TestPartialUpdateDeduplication, TestComponentsName, TestLFUCache, SOLR749Test, UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, CopyFieldTest, SolrIndexConfigTest, BadComponentTest, TestStressRecovery, ChaosMonkeyNothingIsSafeWithPullReplicasTest, CustomCollectionTest, DeleteStatusTest, DocValuesNotIndexedTest, ForceLeaderTest, LeaderFailureAfterFreshStartTest, LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, NodeMutatorTest, OverriddenZkACLAndCredentialsProvidersTest, ReplaceNodeTest, TestCloudJSONFacetJoinDomain, TestExclusionRuleCollectionAccess, TestLeaderElectionZkExpiry, TestMiniSolrCloudClusterSSL, TestReplicaProperties, TestSSLRandomization, TestSizeLimitedDistributedMap, TestTlogReplica, AutoAddReplicasPlanActionTest, NodeLostTriggerTest, TestPolicyCloud, HdfsRecoveryZkTest, RuleEngineTest, ConfigureRecoveryStrategyTest, CoreSorterTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, TestImplicitCoreProperties, TestInfoStreamLogging, TestInitParams, TestSolrConfigHandler, TestSolrXml, TestSolrCloudSnapshots, SearchHandlerTest, TestBlobHandler, TestHdfsBackupRestoreCore, TestSQLHandler, CoreAdminRequestStatusTest, CoreMergeIndexesAdminHandlerTest, InfoHandlerTest, TestApiFramework, TestCollectionAPIs, TestConfigsApi, DistributedExpandComponentTest, DistributedFacetExistsSmallTest, DistributedFacetPivotLongTailTest, DistributedFacetPivotSmallTest, DistributedFacetPivotWhiteBoxTest, DistributedSuggestComponentTest, FacetPivotSmallTest, InfixSuggestersTest, SpatialHeatmapFacetsTest, TestHttpShardHandlerFactory, TestTrackingShardHandlerFactory, SolrMetricManagerTest, SolrGangliaReporterTest, SolrJmxReporterCloudTest, SolrCloudReportersTest, TestStreamBody, TestMacroExpander, TestMacros, SmileWriterTest, TestRawResponseWriter, TestSolrQueryResponse, TestChildDocTransformer, TestDynamicFieldResource, TestFieldResource, TestFieldTypeCollectionResource, TestFieldTypeResource, TestSchemaNameResource, TestSchemaResource, TestSchemaSimilarityResource, TestSchemaVersionResource, TestSerializedLuceneMatchVersion, TestManagedStopFilterFactory, TestManagedSynonymFilterFactory, BadCopyFieldTest, BooleanFieldTest, ChangedSchemaMergeTest, DateRangeFieldTest, DocValuesMissingTest, TestCollationFieldDocValues, TestSchemaManager, TestSchemalessBufferedUpdates, TestUseDocValuesAsStored, CursorMarkTest, RankQueryTest, SortSpecParsingTest, TestAddFieldRealTimeGet, TestCollapseQParserPlugin, TestFilteredDocIdSet, TestHashQParserPlugin, TestLegacyNumericRangeQueryBuilder, TestMultiWordSynonyms, TestOverriddenPrefixQueryForCustomFieldType, TestRandomCollapseQParserPlugin, TestReloadDeadlock, TestSimpleQParserPlugin, TestSmileRequest, TestTrieFacet, TestXmlQParser, TestJsonFacetRefinement, TestJsonFacets, BasicAuthStandaloneTest, TestSha256AuthenticationProvider, TestImpersonationWithHadoopAuth, HdfsLockFactoryTest, TestDocTermOrds, TestFieldCache, TestFieldCacheReopen, TestFieldCacheVsDocValues, TestFieldCacheWithThreads, CdcrUpdateLogTest, DataDrivenBlockJoinTest, TestDocBasedVersionConstraints, TestExceedMaxTermLength, TestInPlaceUpdatesDistrib, TimePartitionedUpdateProcessorTest]
[junit4] Completed [741/750 (4!)] on J1 in 16.09s, 2 tests, 1 failure <<< FAILURES!
[...truncated 47319 lines...]
[JENKINS] Lucene-Solr-master-Solaris (64bit/jdk1.8.0) - Build #
1537 - Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/1537/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
2 tests failed.
FAILED: org.apache.solr.cloud.TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateSearchDelete
Error Message:
Error from server at http://127.0.0.1:59422/solr/testcollection_shard1_replica_n2: Expected mime type application/octet-stream but got text/html. <html> <head> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/> <title>Error 404 </title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem accessing /solr/testcollection_shard1_replica_n2/update. Reason: <pre> Can not find: /solr/testcollection_shard1_replica_n2/update</pre></p> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.20.v20170531</a><hr/> </body> </html>
Stack Trace:
org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Error from server at http://127.0.0.1:59422/solr/testcollection_shard1_replica_n2: Expected mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /solr/testcollection_shard1_replica_n2/update. Reason:
<pre> Can not find: /solr/testcollection_shard1_replica_n2/update</pre></p>
<hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.20.v20170531</a><hr/>
</body>
</html>
at __randomizedtesting.SeedInfo.seed([99B6A6A385A81FAD:3A4C08060240F508]:0)
at org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:549)
at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1016)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:883)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:945)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:945)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:945)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:945)
at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:945)
at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:816)
at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233)
at org.apache.solr.cloud.TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateSearchDelete(TestCollectionsAPIViaSolrCloudCluster.java:167)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:59422/solr/testcollection_shard1_replica_n2: Expected mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /solr/testcollection_shard1_replica_n2/update. Reason:
<pre> Can not find: /solr/testcollection_shard1_replica_n2/update</pre></p>
<hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.20.v20170531</a><hr/>
</body>
</html>
at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:607)
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.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:526)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
... 1 more
FAILED: org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster
Error Message:
Document mismatch on target after sync expected:<2000> but was:<1901>
Stack Trace:
java.lang.AssertionError: Document mismatch on target after sync expected:<2000> but was:<1901>
at __randomizedtesting.SeedInfo.seed([99B6A6A385A81FAD:4DF3EDFA62FEAC56]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster(CdcrBootstrapTest.java:292)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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 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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12174 lines...]
[junit4] Suite: org.apache.solr.cloud.TestCollectionsAPIViaSolrCloudCluster
[junit4] 2> 1029068 INFO (SUITE-TestCollectionsAPIViaSolrCloudCluster-seed#[99B6A6A385A81FAD]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/init-core-data-001
[junit4] 2> 1029068 WARN (SUITE-TestCollectionsAPIViaSolrCloudCluster-seed#[99B6A6A385A81FAD]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 1029069 INFO (SUITE-TestCollectionsAPIViaSolrCloudCluster-seed#[99B6A6A385A81FAD]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 1029070 INFO (SUITE-TestCollectionsAPIViaSolrCloudCluster-seed#[99B6A6A385A81FAD]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 1029071 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001
[junit4] 2> 1029072 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1029072 INFO (Thread-4079) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1029072 INFO (Thread-4079) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1029074 ERROR (Thread-4079) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1029172 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.ZkTestServer start zk server on port:40304
[junit4] 2> 1029179 INFO (jetty-launcher-1961-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1029179 INFO (jetty-launcher-1961-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1029179 INFO (jetty-launcher-1961-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1029180 INFO (jetty-launcher-1961-thread-4) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1029180 INFO (jetty-launcher-1961-thread-5) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1029181 INFO (jetty-launcher-1961-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3e4f020f{/solr,null,AVAILABLE}
[junit4] 2> 1029182 INFO (jetty-launcher-1961-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4624b0e5{/solr,null,AVAILABLE}
[junit4] 2> 1029182 INFO (jetty-launcher-1961-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5dcecb21{/solr,null,AVAILABLE}
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@215fc43b{HTTP/1.1,[http/1.1]}{127.0.0.1:48958}
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.e.j.s.Server Started @1031001ms
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=48958}
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4df09e53{/solr,null,AVAILABLE}
[junit4] 2> 1029183 ERROR (jetty-launcher-1961-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1029183 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:40.736Z
[junit4] 2> 1029184 INFO (jetty-launcher-1961-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5cf428d9{/solr,null,AVAILABLE}
[junit4] 2> 1029184 INFO (jetty-launcher-1961-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3fefcc21{HTTP/1.1,[http/1.1]}{127.0.0.1:56983}
[junit4] 2> 1029184 INFO (jetty-launcher-1961-thread-3) [ ] o.e.j.s.Server Started @1031002ms
[junit4] 2> 1029184 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56983}
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@70a4cbc9{HTTP/1.1,[http/1.1]}{127.0.0.1:64475}
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@662cc0e7{HTTP/1.1,[http/1.1]}{127.0.0.1:56266}
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.e.j.s.Server Started @1031003ms
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.e.j.s.Server Started @1031003ms
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64475}
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=56266}
[junit4] 2> 1029185 ERROR (jetty-launcher-1961-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1029185 ERROR (jetty-launcher-1961-thread-5) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:40.738Z
[junit4] 2> 1029185 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:40.738Z
[junit4] 2> 1029186 ERROR (jetty-launcher-1961-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1029186 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1029186 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1029186 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1029186 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:40.739Z
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2b846b1f{HTTP/1.1,[http/1.1]}{127.0.0.1:45412}
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.e.j.s.Server Started @1031006ms
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45412}
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1029188 ERROR (jetty-launcher-1961-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1029188 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:40.741Z
[junit4] 2> 1029190 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1029190 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1029195 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1029195 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15fccc458520002, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1029197 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15fccc458520003, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1029198 INFO (jetty-launcher-1961-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40304/solr
[junit4] 2> 1029199 INFO (jetty-launcher-1961-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40304/solr
[junit4] 2> 1029201 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 1029202 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15fccc458520004, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1029202 INFO (jetty-launcher-1961-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40304/solr
[junit4] 2> 1029207 INFO (jetty-launcher-1961-thread-4) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40304/solr
[junit4] 2> 1029211 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15fccc458520009, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1029213 INFO (jetty-launcher-1961-thread-5) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40304/solr
[junit4] 2> 1029431 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1029434 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:64475_solr
[junit4] 2> 1029434 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1029436 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.c.Overseer Overseer (id=99022860492865548-127.0.0.1:64475_solr-n_0000000000) starting
[junit4] 2> 1029436 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1029436 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56983_solr
[junit4] 2> 1029441 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1029442 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1029443 INFO (zkCallback-1988-thread-1-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1029443 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1029444 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1029445 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1029445 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:56266_solr
[junit4] 2> 1029448 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1029450 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1029451 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1029452 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:48958_solr
[junit4] 2> 1029453 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1029459 INFO (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1029459 INFO (zkCallback-1988-thread-1-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1029462 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1029462 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1029462 INFO (zkCallback-1980-thread-2-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1029462 INFO (zkCallback-1988-thread-2-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1029463 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1029491 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45412_solr
[junit4] 2> 1029504 INFO (zkCallback-1980-thread-2-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1029504 INFO (zkCallback-1988-thread-2-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1029513 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1029514 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1029539 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1029547 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56983.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029552 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56983.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029552 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56983.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029553 INFO (jetty-launcher-1961-thread-3) [n:127.0.0.1:56983_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001/node3/.
[junit4] 2> 1029581 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:64475_solr
[junit4] 2> 1029588 INFO (zkCallback-1980-thread-2-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1029588 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1029588 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1029588 INFO (zkCallback-1988-thread-2-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1029588 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1029712 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56266.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029715 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_48958.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029716 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45412.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029775 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64475.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029775 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45412.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029775 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_48958.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029775 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_45412.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029775 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_48958.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029776 INFO (jetty-launcher-1961-thread-4) [n:127.0.0.1:45412_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001/node4/.
[junit4] 2> 1029776 INFO (jetty-launcher-1961-thread-1) [n:127.0.0.1:48958_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001/node1/.
[junit4] 2> 1029781 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64475.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029781 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_64475.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029782 INFO (jetty-launcher-1961-thread-2) [n:127.0.0.1:64475_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001/node2/.
[junit4] 2> 1029783 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56266.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029783 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_56266.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@5e8ffb1c
[junit4] 2> 1029784 INFO (jetty-launcher-1961-thread-5) [n:127.0.0.1:56266_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-001/node5/.
[junit4] 2> 1029900 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from client sessionid 0x15fccc458520010, likely client has closed socket
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1029904 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1029905 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:40304/solr ready
[junit4] 2> 1029909 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testCollectionCreateWithoutCoresThenDelete
[junit4] 2> 1029911 INFO (qtp1324180000-12705) [n:127.0.0.1:56983_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&replicationFactor=2&collection.configName=solrCloudCollectionConfig&maxShardsPerNode=1&name=testSolrCloudCollectionWithoutCores&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=EMPTY&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1029913 INFO (qtp1324180000-12705) [n:127.0.0.1:56983_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&replicationFactor=2&collection.configName=solrCloudCollectionConfig&maxShardsPerNode=1&name=testSolrCloudCollectionWithoutCores&nrtReplicas=2&action=CREATE&numShards=2&createNodeSet=EMPTY&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 1029914 INFO (qtp1324180000-12707) [n:127.0.0.1:56983_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1029916 INFO (qtp1324180000-12707) [n:127.0.0.1:56983_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 1029916 INFO (OverseerThreadFactory-3803-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.CreateCollectionCmd Create collection testSolrCloudCollectionWithoutCores
[junit4] 2> 1029917 WARN (OverseerThreadFactory-3803-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.CreateCollectionCmd It is unusual to create a collection (testSolrCloudCollectionWithoutCores) without cores.
[junit4] 2> 1030035 INFO (OverseerThreadFactory-3803-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1030917 INFO (qtp1324180000-12708) [n:127.0.0.1:56983_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1030920 INFO (qtp1324180000-12708) [n:127.0.0.1:56983_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=2
[junit4] 2> 1030921 INFO (qtp1324180000-12703) [n:127.0.0.1:56983_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=DELETESTATUS&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1030922 INFO (qtp1324180000-12703) [n:127.0.0.1:56983_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=8e04a9c3-d72b-4c45-9fd2-cf7ed7f42c60&action=DELETESTATUS&wt=javabin&version=2} status=0 QTime=1
[junit4] 2> 1030923 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: testSolrCloudCollectionWithoutCores failOnTimeout:true timeout (sec):330
[junit4] 1> -
[junit4] 1> no one is recoverying
[junit4] 2> 1030924 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: testSolrCloudCollectionWithoutCores
[junit4] 2> 1030926 INFO (qtp1324180000-12709) [n:127.0.0.1:56983_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params name=testSolrCloudCollectionWithoutCores&action=DELETE&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 1030933 INFO (OverseerCollectionConfigSetProcessor-99022860492865548-127.0.0.1:64475_solr-n_0000000000) [n:127.0.0.1:64475_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may have disconnected from ZooKeeper
[junit4] 2> 1030934 INFO (OverseerThreadFactory-3803-thread-2-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 1031651 INFO (qtp1324180000-12709) [n:127.0.0.1:56983_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={name=testSolrCloudCollectionWithoutCores&action=DELETE&wt=javabin&version=2} status=0 QTime=725
[junit4] 2> 1031652 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.AbstractDistribZkTestBase Wait for collection to disappear - collection: testSolrCloudCollectionWithoutCores failOnTimeout:true timeout (sec):330
[junit4] 1> -
[junit4] 2> 1031652 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.AbstractDistribZkTestBase Collection has disappeared - collection: testSolrCloudCollectionWithoutCores
[junit4] 2> 1031658 INFO (jetty-closer-1962-thread-5) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@70a4cbc9{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1031659 INFO (jetty-closer-1962-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3fefcc21{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1031660 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=572638407
[junit4] 2> 1031660 INFO (jetty-closer-1962-thread-2) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2b846b1f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1031660 INFO (jetty-closer-1962-thread-3) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@215fc43b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1031662 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1031662 INFO (jetty-closer-1962-thread-4) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@662cc0e7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1031662 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@40e510e7: rootName = solr_64475, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7cd79b51
[junit4] 2> 1031661 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2119092869
[junit4] 2> 1031663 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1463176196
[junit4] 2> 1031661 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=745717464
[junit4] 2> 1031663 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1031663 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1031664 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@405ae3d5: rootName = solr_56266, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@146c373b
[junit4] 2> 1031664 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1031664 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2ffd910a: rootName = solr_45412, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@18a854c9
[junit4] 2> 1031663 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1476459922
[junit4] 2> 1031668 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 1031668 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1b985eaa: rootName = solr_48958, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@2f42426c
[junit4] 2> 1031664 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@4063106e: rootName = solr_56983, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@28a2a162
[junit4] 2> 1031766 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1031766 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d7f33bc: rootName = solr_45412, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@11f5847d
[junit4] 2> 1031766 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1031766 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2284e920: rootName = solr_56266, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@11f5847d
[junit4] 2> 1031770 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1031770 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@626cab88: rootName = solr_64475, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@11f5847d
[junit4] 2> 1031772 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1031772 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7042dd61: rootName = solr_48958, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@11f5847d
[junit4] 2> 1031772 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 1031772 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@302317bb: rootName = solr_56983, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@11f5847d
[junit4] 2> 1031827 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1031827 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@675dc772: rootName = solr_45412, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@77dda323
[junit4] 2> 1031827 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1031827 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2dab20e2: rootName = solr_56266, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@77dda323
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@26af28a9: rootName = solr_56983, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@77dda323
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2a38236e: rootName = solr_48958, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@77dda323
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 1031828 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7848c87: rootName = solr_64475, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@77dda323
[junit4] 2> 1031829 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:56266_solr
[junit4] 2> 1031830 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:45412_solr
[junit4] 2> 1031831 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:56983_solr
[junit4] 2> 1031831 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1031831 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:64475_solr
[junit4] 2> 1031831 INFO (zkCallback-1982-thread-1-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1031832 INFO (zkCallback-1988-thread-1-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1031831 INFO (zkCallback-1980-thread-2-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1031832 INFO (zkCallback-1984-thread-2-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1031831 INFO (zkCallback-1988-thread-2-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1031831 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (4)
[junit4] 2> 1031832 INFO (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1031832 INFO (zkCallback-1983-thread-1-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (3)
[junit4] 2> 1031832 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1031835 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.c.ZkController Remove node as live in ZooKeeper:/live_nodes/127.0.0.1:48958_solr
[junit4] 2> 1031836 INFO (jetty-closer-1962-thread-4) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1031836 INFO (jetty-closer-1962-thread-2) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1031837 INFO (zkCallback-1982-thread-2-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 1031838 INFO (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (1)
[junit4] 2> 1031839 INFO (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0)
[junit4] 2> 1031839 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1031839 INFO (jetty-closer-1962-thread-3) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1031840 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1031841 INFO (zkCallback-1983-thread-2-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0)
[junit4] 2> 1031841 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1031841 INFO (jetty-closer-1962-thread-5) [ ] o.a.s.c.Overseer Overseer (id=99022860492865548-127.0.0.1:64475_solr-n_0000000000) closing
[junit4] 2> 1031841 INFO (OverseerStateUpdate-99022860492865548-127.0.0.1:64475_solr-n_0000000000) [n:127.0.0.1:64475_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:64475_solr
[junit4] 2> 1031842 WARN (OverseerAutoScalingTriggerThread-99022860492865548-127.0.0.1:64475_solr-n_0000000000) [n:127.0.0.1:64475_solr ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 1031843 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 1031843 INFO (jetty-closer-1962-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 1031845 INFO (zkCallback-1982-thread-3-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (0)
[junit4] 2> 1033339 WARN (zkCallback-1988-thread-1-processing-n:127.0.0.1:56266_solr) [n:127.0.0.1:56266_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1033339 INFO (jetty-closer-1962-thread-4) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3e4f020f{/solr,null,UNAVAILABLE}
[junit4] 2> 1033340 WARN (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:56983_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:56983_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033340 WARN (zkCallback-1984-thread-3-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 1033340 WARN (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:48958_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:48958_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033340 WARN (zkCallback-1984-thread-1-processing-n:127.0.0.1:45412_solr) [n:127.0.0.1:45412_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:64475_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:64475_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033341 WARN (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:56983_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:56983_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033342 INFO (jetty-closer-1962-thread-2) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4df09e53{/solr,null,UNAVAILABLE}
[junit4] 2> 1033342 WARN (zkCallback-1980-thread-1-processing-n:127.0.0.1:48958_solr) [n:127.0.0.1:48958_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:64475_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:64475_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033343 INFO (jetty-closer-1962-thread-3) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4624b0e5{/solr,null,UNAVAILABLE}
[junit4] 2> 1033348 WARN (zkCallback-1982-thread-3-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:48958_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:48958_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033348 WARN (zkCallback-1982-thread-3-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:56983_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:56983_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033348 WARN (zkCallback-1982-thread-3-processing-n:127.0.0.1:56983_solr) [n:127.0.0.1:56983_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:64475_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:64475_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033349 INFO (jetty-closer-1962-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5cf428d9{/solr,null,UNAVAILABLE}
[junit4] 2> 1033350 WARN (zkCallback-1983-thread-2-processing-n:127.0.0.1:64475_solr) [n:127.0.0.1:64475_solr ] o.a.s.c.ZkController Unable to register nodeLost path for 127.0.0.1:64475_solr
[junit4] 2> org.apache.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /autoscaling/nodeLost/127.0.0.1:64475_solr
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:127)
[junit4] 2> at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] 2> at org.apache.zookeeper.ZooKeeper.create(ZooKeeper.java:783)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.lambda$create$7(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient.create(SolrZkClient.java:357)
[junit4] 2> at org.apache.solr.cloud.ZkController.lambda$registerLiveNodesListener$2(ZkController.java:879)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.lambda$refreshLiveNodes$1(ZkStateReader.java:704)
[junit4] 2> at java.util.concurrent.ConcurrentHashMap$KeySetView.forEach(ConcurrentHashMap.java:4649)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.refreshLiveNodes(ZkStateReader.java:703)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader.access$900(ZkStateReader.java:74)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.refreshAndWatch(ZkStateReader.java:1104)
[junit4] 2> at org.apache.solr.common.cloud.ZkStateReader$LiveNodeWatcher.process(ZkStateReader.java:1099)
[junit4] 2> at org.apache.solr.common.cloud.SolrZkClient$1.lambda$process$0(SolrZkClient.java:262)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1033350 INFO (jetty-closer-1962-thread-5) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5dcecb21{/solr,null,UNAVAILABLE}
[junit4] 2> 1033352 ERROR (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1033354 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40304 40304
[junit4] 2> 1038487 INFO (Thread-4079) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:40304 40304
[junit4] 2> 1038489 WARN (Thread-4079) [ ] o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 6 /solr/clusterprops.json
[junit4] 2> 5 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/live_nodes
[junit4] 2> 6 /solr/collections
[junit4] 2>
[junit4] 2> 1038489 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testCollectionCreateWithoutCoresThenDelete-seed#[99B6A6A385A81FAD]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCollectionCreateWithoutCoresThenDelete
[junit4] 2> 1038493 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testStopAllStartAll-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 5 servers in /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestCollectionsAPIViaSolrCloudCluster_99B6A6A385A81FAD-001/tempDir-002
[junit4] 2> 1038494 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testStopAllStartAll-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1038494 INFO (Thread-4129) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1038494 INFO (Thread-4129) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 1038497 ERROR (Thread-4129) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 1038594 INFO (TEST-TestCollectionsAPIViaSolrCloudCluster.testStopAllStartAll-seed#[99B6A6A385A81FAD]) [ ] o.a.s.c.ZkTestServer start zk server on port:53321
[junit4] 2> 1038610 INFO (jetty-launcher-2000-thread-4) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1038610 INFO (jetty-launcher-2000-thread-3) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1038610 INFO (jetty-launcher-2000-thread-1) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1038610 INFO (jetty-launcher-2000-thread-2) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1038612 INFO (jetty-launcher-2000-thread-5) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1038613 INFO (jetty-launcher-2000-thread-4) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@53d7c34e{/solr,null,AVAILABLE}
[junit4] 2> 1038615 INFO (jetty-launcher-2000-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58a8bc50{/solr,null,AVAILABLE}
[junit4] 2> 1038615 INFO (jetty-launcher-2000-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1721052c{HTTP/1.1,[http/1.1]}{127.0.0.1:44640}
[junit4] 2> 1038615 INFO (jetty-launcher-2000-thread-3) [ ] o.e.j.s.Server Started @1040435ms
[junit4] 2> 1038616 INFO (jetty-launcher-2000-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=44640}
[junit4] 2> 1038616 ERROR (jetty-launcher-2000-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1038616 INFO (jetty-launcher-2000-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1038616 INFO (jetty-launcher-2000-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1038616 INFO (jetty-launcher-2000-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1038616 INFO (jetty-launcher-2000-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:50.169Z
[junit4] 2> 1038623 INFO (jetty-launcher-2000-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@e546dd5{/solr,null,AVAILABLE}
[junit4] 2> 1038624 INFO (jetty-launcher-2000-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@416bf5c4{HTTP/1.1,[http/1.1]}{127.0.0.1:45701}
[junit4] 2> 1038624 INFO (jetty-launcher-2000-thread-1) [ ] o.e.j.s.Server Started @1040443ms
[junit4] 2> 1038624 INFO (jetty-launcher-2000-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=45701}
[junit4] 2> 1038624 ERROR (jetty-launcher-2000-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1038624 INFO (jetty-launcher-2000-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1038624 INFO (jetty-launcher-2000-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1038625 INFO (jetty-launcher-2000-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1038625 INFO (jetty-launcher-2000-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:50.178Z
[junit4] 2> 1038627 INFO (jetty-launcher-2000-thread-4) [ ] o.e.j.s.AbstractConnector Started ServerConnector@48eb468a{HTTP/1.1,[http/1.1]}{127.0.0.1:64413}
[junit4] 2> 1038627 INFO (jetty-launcher-2000-thread-4) [ ] o.e.j.s.Server Started @1040446ms
[junit4] 2> 1038627 INFO (jetty-launcher-2000-thread-4) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=64413}
[junit4] 2> 1038627 ERROR (jetty-launcher-2000-thread-4) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1038628 INFO (jetty-launcher-2000-thread-4) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1038628 INFO (jetty-launcher-2000-thread-4) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1038628 INFO (jetty-launcher-2000-thread-4) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1038628 INFO (jetty-launcher-2000-thread-4) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:50.181Z
[junit4] 2> 1038630 INFO (jetty-launcher-2000-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3e5cc4ac{/solr,null,AVAILABLE}
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7b15cf4c{HTTP/1.1,[http/1.1]}{127.0.0.1:65181}
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.e.j.s.Server Started @1040450ms
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=65181}
[junit4] 2> 1038631 ERROR (jetty-launcher-2000-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.0.0
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1038631 INFO (jetty-launcher-2000-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-11-18T01:35:50.184Z
[junit4] 2> 1038636 INFO (jetty-launcher-2000-thread-5) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5cad07c2{/solr,null,AVAILABLE}
[junit4] 2> 1038639 INFO (jetty-launcher-2000-thread-5) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6fa97894{HTTP/1.1,[http/1.1]}{127.0.0.1:56027}
[junit4] 2> 1038639 INFO (jetty-launcher-2000
[...truncated too long message...]
ests.seed=99B6A6A385A81FAD -Dtests.slow=true -Dtests.locale=sr-Latn-RS -Dtests.timezone=Pacific/Funafuti -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 140s J0 | CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster <<<
[junit4] > Throwable #1: java.lang.AssertionError: Document mismatch on target after sync expected:<2000> but was:<1901>
[junit4] > at __randomizedtesting.SeedInfo.seed([99B6A6A385A81FAD:4DF3EDFA62FEAC56]:0)
[junit4] > at org.apache.solr.cloud.cdcr.CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster(CdcrBootstrapTest.java:292)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> NOTE: leaving temporary files on disk at: /export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.cdcr.CdcrBootstrapTest_99B6A6A385A81FAD-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {xyz=FST50, id=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{_version_=DocValuesFormat(name=Lucene70), xyz=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=1460, maxMBSortInHeap=7.64895602412822, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@5772a12a), locale=sr-Latn-RS, timezone=Pacific/Funafuti
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=3,threads=1,free=156386736,total=481394688
[junit4] 2> NOTE: All tests run in this JVM: [TestSortByMinMaxFunction, ReturnFieldsTest, StressHdfsTest, OverseerRolesTest, TestLazyCores, HighlighterMaxOffsetTest, FieldAnalysisRequestHandlerTest, TemplateUpdateProcessorTest, TestCopyFieldCollectionResource, TestJsonRequest, TestTolerantUpdateProcessorCloud, TestInPlaceUpdatesDistrib, DirectUpdateHandlerOptimizeTest, VMParamsZkACLAndCredentialsProvidersTest, TestNumericRangeQuery64, HdfsBasicDistributedZk2Test, AnalyticsMergeStrategyTest, OverseerTest, TestReplicationHandlerBackup, RAMDirectoryFactoryTest, TestExceedMaxTermLength, TestJoin, TestSolr4Spatial2, BadIndexSchemaTest, TimePartitionedUpdateProcessorTest, TestJsonFacetRefinement, SuggesterTest, TestPHPSerializedResponseWriter, TestImplicitCoreProperties, EnumFieldTest, SolrInfoBeanTest, TestSubQueryTransformerCrossCore, TestCloudInspectUtil, CleanupOldIndexTest, DateRangeFieldTest, DateFieldTest, CdcrBidirectionalTest, TestOverriddenPrefixQueryForCustomFieldType, HighlighterTest, DeleteInactiveReplicaTest, TestDefaultStatsCache, AutoscalingHistoryHandlerTest, DistributedFacetExistsSmallTest, TestStressCloudBlindAtomicUpdates, TestFiltering, TestCSVResponseWriter, RecoveryZkTest, TestLFUCache, SpellCheckCollatorTest, TestUtils, TestSchemaResource, TestRequestForwarding, TestMacros, TestSolrCoreProperties, HdfsRecoverLeaseTest, TestRangeQuery, TlogReplayBufferedWhileIndexingTest, XmlUpdateRequestHandlerTest, UnloadDistributedZkTest, TestQuerySenderListener, SpellCheckComponentTest, HdfsThreadLeakTest, TestExclusionRuleCollectionAccess, TestSchemaVersionResource, TestLRUStatsCache, HdfsDirectoryFactoryTest, TestFieldSortValues, BasicDistributedZkTest, ClusterStateTest, AtomicUpdatesTest, ZkControllerTest, OutOfBoxZkACLAndCredentialsProvidersTest, ShowFileRequestHandlerTest, DistributedSuggestComponentTest, TestCloudManagedSchema, TestCursorMarkWithoutUniqueKey, TestRuleBasedAuthorizationPlugin, ZkStateReaderTest, TestConfigSets, TestGraphTermsQParserPlugin, SpatialFilterTest, TestEmbeddedSolrServerSchemaAPI, TestAnalyzeInfixSuggestions, TestHighFrequencyDictionaryFactory, TestSolrDeletionPolicy2, CoreAdminRequestStatusTest, HttpTriggerListenerTest, UUIDUpdateProcessorFallbackTest, TestXmlQParser, TestStressLiveNodes, TestOmitPositions, TestCoreDiscovery, TestRawResponseWriter, TestPullReplica, MinimalSchemaTest, CreateCollectionCleanupTest, TestSlowCompositeReaderWrapper, TestReloadAndDeleteDocs, TestManagedSchemaThreadSafety, TestPerFieldSimilarityWithDefaultOverride, TestCollectionsAPIViaSolrCloudCluster, TestStressRecovery, TestGeoJSONResponseWriter, HdfsRestartWhileUpdatingTest, SolrTestCaseJ4Test, AddSchemaFieldsUpdateProcessorFactoryTest, HttpPartitionTest, UUIDFieldTest, TestUpdate, TestUninvertingReader, TestHighlightDedupGrouping, TestSolrCloudWithHadoopAuthPlugin, TestSolrConfigHandlerConcurrent, TestCustomDocTransformer, TestInitParams, TestSSLRandomization, ConvertedLegacyTest, TestCloudRecovery, TestConfigSetsAPIExclusivity, TestFieldTypeResource, TestXIncludeConfig, ExecutePlanActionTest, TestManagedResource, RestartWhileUpdatingTest, TestConfigSetImmutable, TestMinMaxOnMultiValuedField, TestSolrCoreSnapshots, InfixSuggestersTest, MetricsConfigTest, TestSimpleQParserPlugin, TestCryptoKeys, DistributedVersionInfoTest, CollectionTooManyReplicasTest, TestSimpleTextCodec, RulesTest, V2ApiIntegrationTest, TestDistribDocBasedVersion, HdfsUnloadDistributedZkTest, PropertiesRequestHandlerTest, SystemLogListenerTest, CdcrRequestHandlerTest, TestDFISimilarityFactory, SimpleMLTQParserTest, DistribCursorPagingTest, NoCacheHeaderTest, BadCopyFieldTest, ClassificationUpdateProcessorIntegrationTest, TestPayloadScoreQParserPlugin, WrapperMergePolicyFactoryTest, MoveReplicaHDFSTest, DateMathParserTest, TestUseDocValuesAsStored, TestStressUserVersions, SolrCloudReportersTest, DistributedDebugComponentTest, SolrMetricsIntegrationTest, ChaosMonkeyNothingIsSafeTest, DirectUpdateHandlerTest, ShardRoutingTest, LeaderInitiatedRecoveryOnCommitTest, QueryParsingTest, TestMultiWordSynonyms, TestReplicationHandler, SolrJmxReporterTest, ChaosMonkeySafeLeaderWithPullReplicasTest, ZkCLITest, ChangedSchemaMergeTest, ConfigSetsAPITest, SliceStateTest, TestReversedWildcardFilterFactory, DistanceFunctionTest, TestDocTermOrds, TestLegacyNumericUtils, TestRetrieveFieldsOptimizer, ReplaceNodeTest, PrimitiveFieldTypeTest, MetricUtilsTest, SolrCloudExampleTest, TestScoreJoinQPNoScore, IgnoreCommitOptimizeUpdateProcessorFactoryTest, CSVRequestHandlerTest, TestAuthenticationFramework, TestCloudNestedDocsSort, SearchHandlerTest, CdcrReplicationDistributedZkTest, OpenCloseCoreStressTest, ClusterStateUpdateTest, LeaderElectionTest, TestRandomDVFaceting, TestDistributedSearch, TermVectorComponentDistributedTest, DistributedTermsComponentTest, StatsComponentTest, TestBadConfig, DistributedQueryElevationComponentTest, SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SolrRequestParserTest, TestFoldingMultitermQuery, SuggesterTSTTest, SuggesterWFSTTest, PolyFieldTest, WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestAtomicUpdateErrorCases, QueryEqualityTest, DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest, TestRemoteStreaming, XsltUpdateRequestHandlerTest, DebugComponentTest, IndexBasedSpellCheckerTest, TestSurroundQueryParser, DisMaxRequestHandlerTest, TestQueryUtils, TestWriterPerf, DirectSolrSpellCheckerTest, DocumentAnalysisRequestHandlerTest, FileBasedSpellCheckerTest, TermsComponentTest, RequestHandlersTest, TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, TestIndexingPerformance, RequiredFieldsTest, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, RegexBoostProcessorTest, SolrPluginUtilsTest, IndexSchemaTest, TestJmxIntegration, TestCollationField, UpdateRequestProcessorFactoryTest, MBeansHandlerTest, TestAnalyzedSuggestions, UniqFieldsUpdateProcessorFactoryTest, BinaryUpdateRequestHandlerTest, PingRequestHandlerTest, TestComponentsName, HighlighterConfigTest, UpdateParamsTest, AlternateDirectoryTest, TestQuerySenderNoQuery, ResponseLogComponentTest, SolrIndexConfigTest, TestMergePolicyConfig, MultiTermTest, SampleTest, TestDocSet, TestBinaryField, NumericFieldsTest, TestElisionMultitermQuery, TestConfig, OutputWriterTest, TestFuzzyAnalyzedSuggestions, DirectSolrConnectionTest, NotRequiredUniqueKeyTest, TestLuceneMatchVersion, TestPhraseSuggestions, SpellPossibilityIteratorTest, TestCharFilters, TestCodecSupport, SynonymTokenizerTest, TestSweetSpotSimilarityFactory, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestLMDirichletSimilarityFactory, TestIBSimilarityFactory, TestFastWriter, TimeZoneUtilsTest, ResourceLoaderTest, TestFastOutputStream, ScriptEngineTest, OpenExchangeRatesOrgProviderTest, URLClassifyProcessorTest, PluginInfoTest, PreAnalyzedFieldTest, TestSystemIdResolver, PrimUtilsTest, TestSuggestSpellingConverter, TestSolrJ, TestDocumentBuilder, SystemInfoHandlerTest, FileUtilsTest, CircularListTest, TestRTGBase, CursorPagingTest, DistributedIntervalFacetingTest, TestSimpleTrackingShardHandler, TestTolerantSearch, TestLuceneIndexBackCompat, TestEmbeddedSolrServerAdminHandler, TestJettySolrRunner, ActionThrottleTest, AddReplicaTest, AssignBackwardCompatibilityTest, AsyncCallRequestStatusResponseTest, CloudExitableDirectoryReaderTest, CollectionReloadTest, CollectionStateFormat2Test, DeleteLastCustomShardedReplicaTest, DeleteNodeTest, DeleteReplicaTest, DeleteShardTest, DistribJoinFromCollectionTest, DocValuesNotIndexedTest, ForceLeaderTest, LeaderInitiatedRecoveryOnShardRestartTest, LegacyCloudClusterPropTest, MoveReplicaHDFSFailoverTest, PeerSyncReplicationTest, SharedFSAutoReplicaFailoverTest, SimpleCollectionCreateDeleteTest, SolrCLIZkUtilsTest, TestCloudJSONFacetJoinDomain, TestCloudPivotFacet, TestClusterProperties, TestCollectionAPI, TestConfigSetsAPIZkFailure, TestLeaderElectionWithEmptyReplica, TestLeaderInitiatedRecoveryThread, TestLocalFSCloudBackupRestore, TestLockTree, TestMiniSolrCloudClusterSSL, TestOnReconnectListenerSupport, TestPrepRecovery, TestPullReplicaErrorHandling, TestRandomFlRTGCloud, TestRebalanceLeaders, TestReplicaProperties, TestRequestStatusCollectionAPI, TestSkipOverseerOperations, TestSolrCloudWithSecureImpersonation, AutoAddReplicasIntegrationTest, HdfsAutoAddReplicasIntegrationTest, CdcrBootstrapTest]
[junit4] Completed [592/750 (2!)] on J0 in 203.84s, 3 tests, 1 failure <<< FAILURES!
[...truncated 47792 lines...]