Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/692/
4 tests failed.
FAILED: org.apache.solr.cloud.OverseerRolesTest.testOverseerRole
Error Message:
Timed out waiting for overseer state change
Stack Trace:
java.lang.AssertionError: Timed out waiting for overseer state change
at
__randomizedtesting.SeedInfo.seed([73D6C13450011BAB:921D3CA06BB22D7A]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:62)
at
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:140)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:745)
FAILED: org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_stored_idx
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([73D6C13450011BAB:63B76CCD45A35E85]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:187)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.waitForRecoveriesToFinish(TestStressCloudBlindAtomicUpdates.java:459)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.checkField(TestStressCloudBlindAtomicUpdates.java:304)
at
org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates.test_stored_idx(TestStressCloudBlindAtomicUpdates.java:234)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:745)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestDetails
Error Message:
expected:<2> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<2> but was:<1>
at
__randomizedtesting.SeedInfo.seed([73D6C13450011BAB:98BE241C6593223]: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.handler.TestReplicationHandler.doTestDetails(TestReplicationHandler.java:314)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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:745)
FAILED:
junit.framework.TestSuite.org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin
Error Message:
Address already in use
Stack Trace:
java.net.BindException: Address already in use
at __randomizedtesting.SeedInfo.seed([73D6C13450011BAB]:0)
at sun.nio.ch.Net.bind0(Native Method)
at sun.nio.ch.Net.bind(Net.java:433)
at sun.nio.ch.Net.bind(Net.java:425)
at
sun.nio.ch.ServerSocketChannelImpl.bind(ServerSocketChannelImpl.java:223)
at sun.nio.ch.ServerSocketAdaptor.bind(ServerSocketAdaptor.java:74)
at
org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:252)
at
org.apache.mina.transport.socket.nio.NioSocketAcceptor.open(NioSocketAcceptor.java:49)
at
org.apache.mina.core.polling.AbstractPollingIoAcceptor.registerHandles(AbstractPollingIoAcceptor.java:525)
at
org.apache.mina.core.polling.AbstractPollingIoAcceptor.access$200(AbstractPollingIoAcceptor.java:67)
at
org.apache.mina.core.polling.AbstractPollingIoAcceptor$Acceptor.run(AbstractPollingIoAcceptor.java:409)
at
org.apache.mina.util.NamePreservingRunnable.run(NamePreservingRunnable.java:65)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11354 lines...]
[junit4] Suite: org.apache.solr.cloud.OverseerRolesTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/init-core-data-001
[junit4] 2> 530918 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 530918 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/tempDir-001
[junit4] 2> 530918 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 530922 INFO (Thread-984) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 530922 INFO (Thread-984) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 531019 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:48713
[junit4] 2> 531045 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 531046 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 531047 INFO (jetty-launcher-601-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 531058 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 531068 INFO (jetty-launcher-601-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5b125f11{/solr,null,AVAILABLE}
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@5b37d501{HTTP/1.1,[http/1.1]}{127.0.0.1:33069}
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.e.j.s.Server Started @535881ms
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=33069}
[junit4] 2> 531069 ERROR (jetty-launcher-601-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 531069 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:33:24.718Z
[junit4] 2> 531076 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@b531f80{/solr,null,AVAILABLE}
[junit4] 2> 531076 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@649df1f4{HTTP/1.1,[http/1.1]}{127.0.0.1:37736}
[junit4] 2> 531076 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.Server Started @535889ms
[junit4] 2> 531076 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37736}
[junit4] 2> 531077 ERROR (jetty-launcher-601-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 531077 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 531077 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 531077 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 531077 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:33:24.726Z
[junit4] 2> 531087 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2ef0d7b6{/solr,null,AVAILABLE}
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@473764db{HTTP/1.1,[http/1.1]}{127.0.0.1:58151}
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.Server Started @535900ms
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=58151}
[junit4] 2> 531088 ERROR (jetty-launcher-601-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 531088 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:33:24.737Z
[junit4] 2> 531099 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@489d948d{/solr,null,AVAILABLE}
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@57d5cd5d{HTTP/1.1,[http/1.1]}{127.0.0.1:39543}
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.Server Started @535912ms
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39543}
[junit4] 2> 531100 ERROR (jetty-launcher-601-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 531100 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:33:24.749Z
[junit4] 2> 531103 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 531118 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 531119 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 531127 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 531134 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 531136 INFO (jetty-launcher-601-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48713/solr
[junit4] 2> 531138 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 531138 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 531144 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48713/solr
[junit4] 2> 531145 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48713/solr
[junit4] 2> 531151 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 531152 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 0x159ce1b2cdc0005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 531158 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48713/solr
[junit4] 2> 531179 INFO (jetty-launcher-601-thread-3)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:33069_solr
[junit4] 2> 531188 INFO (jetty-launcher-601-thread-3)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000000) starting
[junit4] 2> 531244 INFO (jetty-launcher-601-thread-3)
[n:127.0.0.1:33069_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33069_solr
[junit4] 2> 531283 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000000)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 531285 INFO (jetty-launcher-601-thread-4)
[n:127.0.0.1:39543_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39543_solr
[junit4] 2> 531305 INFO
(zkCallback-618-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 531314 INFO (jetty-launcher-601-thread-1)
[n:127.0.0.1:58151_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 531318 INFO (jetty-launcher-601-thread-2)
[n:127.0.0.1:37736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 531323 INFO
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 531340 INFO (jetty-launcher-601-thread-1)
[n:127.0.0.1:58151_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:58151_solr
[junit4] 2> 531342 INFO
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 531342 INFO
(zkCallback-618-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 531344 INFO (jetty-launcher-601-thread-2)
[n:127.0.0.1:37736_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37736_solr
[junit4] 2> 531346 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 531352 INFO
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 531356 INFO (jetty-launcher-601-thread-3)
[n:127.0.0.1:33069_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/tempDir-001/node3/.
[junit4] 2> 531356 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 531356 INFO
(zkCallback-618-thread-2-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 531360 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 531369 INFO (jetty-launcher-601-thread-4)
[n:127.0.0.1:39543_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/tempDir-001/node4/.
[junit4] 2> 531376 INFO
(zkCallback-623-thread-2-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 531398 INFO (jetty-launcher-601-thread-1)
[n:127.0.0.1:58151_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/tempDir-001/node1/.
[junit4] 2> 531419 INFO (jetty-launcher-601-thread-2)
[n:127.0.0.1:37736_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001/tempDir-001/node2/.
[junit4] 2> 531910 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 531911 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:48713/solr ready
[junit4] 2> 531943 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testOverseerRole
[junit4] 2> 531943 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:33069_solr
[junit4] 2> 531944 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 531944 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest ### Setting overseer designate 127.0.0.1:39543_solr
[junit4] 2> 531950 INFO (qtp427756095-3975) [n:127.0.0.1:37736_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:39543_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 531954 INFO
(OverseerThreadFactory-2124-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:39543_solr
[junit4] 2> 531963 INFO (qtp427756095-3975) [n:127.0.0.1:37736_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:39543_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=14
[junit4] 2> 531964 INFO (Thread-1021) [n:127.0.0.1:33069_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
97335483077230599-127.0.0.1:33069_solr-n_0000000000 overseer designates are
[127.0.0.1:39543_solr]
[junit4] 2> 531965 INFO (Thread-1021) [n:127.0.0.1:33069_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230599-127.0.0.1:33069_solr-n_0000000000,
97335483077230602-127.0.0.1:39543_solr-n_0000000001,
97335483077230604-127.0.0.1:58151_solr-n_0000000002,
97335483077230603-127.0.0.1:37736_solr-n_0000000003]
[junit4] 2> 531967 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000000)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230599-127.0.0.1:33069_solr-n_0000000000"}
127.0.0.1:33069_solr
[junit4] 2> 531968 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000000)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:33069_solr
[junit4] 2> 531970 WARN (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 531974 INFO (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000000) closing
[junit4] 2> 531975 INFO
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:39543_solr
[junit4] 2> 531976 INFO
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230602-127.0.0.1:39543_solr-n_0000000001) starting
[junit4] 2> 532065 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest ### Adding another overseer designate
127.0.0.1:37736_solr
[junit4] 2> 532067 INFO (qtp427756095-3976) [n:127.0.0.1:37736_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:37736_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 532071 INFO
(OverseerThreadFactory-2134-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:37736_solr
[junit4] 2> 532080 INFO (qtp427756095-3976) [n:127.0.0.1:37736_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:37736_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=13
[junit4] 2> 532082 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:39543_solr
[junit4] 2> 532082 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 532082 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.ChaosMonkey monkey: stop shard! 39543
[junit4] 2> 532082 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1073512852
[junit4] 2> 532085 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.Overseer Overseer
(id=97335483077230602-127.0.0.1:39543_solr-n_0000000001) closing
[junit4] 2> 532085 INFO
(OverseerStateUpdate-97335483077230602-127.0.0.1:39543_solr-n_0000000001)
[n:127.0.0.1:39543_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:39543_solr
[junit4] 2> 532095 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 0x159ce1b2cdc000a, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 532095 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 532096 INFO
(zkCallback-618-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 532096 INFO
(zkCallback-623-thread-2-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (4) -> (3)
[junit4] 2> 532096 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:58151_solr
[junit4] 2> 532097 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000002) starting
[junit4] 2> 532115 INFO (zkCallback-630-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 532109 INFO
(OverseerCollectionConfigSetProcessor-97335483077230604-127.0.0.1:58151_solr-n_0000000002)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 97335483077230604-127.0.0.1:58151_solr-n_0000000002 overseer
designates are [127.0.0.1:39543_solr, 127.0.0.1:37736_solr]
[junit4] 2> 532116 INFO
(OverseerCollectionConfigSetProcessor-97335483077230604-127.0.0.1:58151_solr-n_0000000002)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230604-127.0.0.1:58151_solr-n_0000000002,
97335483077230603-127.0.0.1:37736_solr-n_0000000003,
97335483077230599-127.0.0.1:33069_solr-n_0000000004]
[junit4] 2> 532119 INFO
(OverseerStateUpdate-97335483077230604-127.0.0.1:58151_solr-n_0000000002)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230604-127.0.0.1:58151_solr-n_0000000002"}
127.0.0.1:58151_solr
[junit4] 2> 532120 INFO
(OverseerStateUpdate-97335483077230604-127.0.0.1:58151_solr-n_0000000002)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:58151_solr
[junit4] 2> 532127 WARN (OverseerExitThread) [n:127.0.0.1:58151_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 532128 INFO (OverseerExitThread) [n:127.0.0.1:58151_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000002) closing
[junit4] 2> 532137 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37736_solr
[junit4] 2> 532138 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230603-127.0.0.1:37736_solr-n_0000000003) starting
[junit4] 2> 533595 WARN
(zkCallback-621-thread-1-processing-n:127.0.0.1:39543_solr)
[n:127.0.0.1:39543_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 533595 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 533596 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@57d5cd5d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 533596 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@489d948d{/solr,null,UNAVAILABLE}
[junit4] 2> 533597 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest ### Adding last overseer designate
127.0.0.1:58151_solr
[junit4] 2> 533599 INFO (qtp1305314964-3987) [n:127.0.0.1:58151_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:58151_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 533603 INFO
(OverseerThreadFactory-2139-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:58151_solr
[junit4] 2> 533608 INFO (qtp1305314964-3987) [n:127.0.0.1:58151_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:58151_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=9
[junit4] 2> 533609 INFO
(OverseerCollectionConfigSetProcessor-97335483077230603-127.0.0.1:37736_solr-n_0000000003)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 533610 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:37736_solr
[junit4] 2> 533611 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest Election queue:
[junit4] 2> 533619 INFO (qtp1305314964-3988) [n:127.0.0.1:58151_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :removerole with params
node=127.0.0.1:37736_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 533624 INFO
(OverseerThreadFactory-2139-thread-2-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerRoleCmd Overseer role removed from
127.0.0.1:37736_solr
[junit4] 2> 533632 INFO (Thread-1025) [n:127.0.0.1:37736_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
97335483077230603-127.0.0.1:37736_solr-n_0000000003 overseer designates are
[127.0.0.1:39543_solr, 127.0.0.1:58151_solr]
[junit4] 2> 533633 INFO (qtp1305314964-3988) [n:127.0.0.1:58151_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:37736_solr&role=overseer&action=REMOVEROLE&wt=javabin&version=2}
status=0 QTime=14
[junit4] 2> 533633 INFO (Thread-1025) [n:127.0.0.1:37736_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230603-127.0.0.1:37736_solr-n_0000000003,
97335483077230599-127.0.0.1:33069_solr-n_0000000004,
97335483077230604-127.0.0.1:58151_solr-n_0000000005]
[junit4] 2> 533633 INFO (Thread-1025) [n:127.0.0.1:37736_solr ]
o.a.s.c.OverseerNodePrioritizer asking node
97335483077230604-127.0.0.1:58151_solr-n_0000000005 to come join election at
head
[junit4] 2> 533637 INFO (qtp1305314964-3985) [n:127.0.0.1:58151_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=97335483077230604-127.0.0.1:58151_solr-n_0000000005&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 533639 INFO (Thread-1025) [n:127.0.0.1:37736_solr ]
o.a.s.c.OverseerNodePrioritizer asking the old first in line
97335483077230599-127.0.0.1:33069_solr-n_0000000004 to rejoin election
[junit4] 2> 533647 INFO (qtp1207892882-3963) [n:127.0.0.1:33069_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=97335483077230599-127.0.0.1:33069_solr-n_0000000004&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 533651 INFO
(OverseerStateUpdate-97335483077230603-127.0.0.1:37736_solr-n_0000000003)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230603-127.0.0.1:37736_solr-n_0000000003"}
127.0.0.1:37736_solr
[junit4] 2> 533652 INFO
(OverseerStateUpdate-97335483077230603-127.0.0.1:37736_solr-n_0000000003)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:37736_solr
[junit4] 2> 533653 WARN (OverseerExitThread) [n:127.0.0.1:37736_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 533654 INFO (OverseerExitThread) [n:127.0.0.1:37736_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230603-127.0.0.1:37736_solr-n_0000000003) closing
[junit4] 2> 533655 INFO
(zkCallback-618-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:33069_solr
[junit4] 2> 533656 INFO
(zkCallback-618-thread-1-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000004) starting
[junit4] 2> 533676 INFO
(OverseerCollectionConfigSetProcessor-97335483077230599-127.0.0.1:33069_solr-n_0000000004)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 97335483077230599-127.0.0.1:33069_solr-n_0000000004 overseer
designates are [127.0.0.1:39543_solr, 127.0.0.1:58151_solr]
[junit4] 2> 533677 INFO
(OverseerCollectionConfigSetProcessor-97335483077230599-127.0.0.1:33069_solr-n_0000000004)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230599-127.0.0.1:33069_solr-n_0000000004,
97335483077230604-127.0.0.1:58151_solr-n_0000000005,
97335483077230603-127.0.0.1:37736_solr-n_0000000006]
[junit4] 2> 533680 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000004)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230599-127.0.0.1:33069_solr-n_0000000004"}
127.0.0.1:33069_solr
[junit4] 2> 533683 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000004)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:33069_solr
[junit4] 2> 533687 WARN (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 533688 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:58151_solr
[junit4] 2> 533689 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000005) starting
[junit4] 2> 533690 INFO (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000004) closing
[junit4] 2> 533737 INFO (qtp1305314964-3989) [n:127.0.0.1:58151_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with params
node=127.0.0.1:37736_solr&role=overseer&action=ADDROLE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 533741 INFO
(OverseerThreadFactory-2143-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerRoleCmd Overseer role added to
127.0.0.1:37736_solr
[junit4] 2> 533750 INFO (qtp1305314964-3989) [n:127.0.0.1:58151_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={node=127.0.0.1:37736_solr&role=overseer&action=ADDROLE&wt=javabin&version=2}
status=0 QTime=13
[junit4] 2> 533751 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.OverseerRolesTest ### Sending QUIT to overseer 127.0.0.1:58151_solr
[junit4] 2> 533754 INFO
(OverseerStateUpdate-97335483077230604-127.0.0.1:58151_solr-n_0000000005)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230604-127.0.0.1:58151_solr-n_0000000005"}
127.0.0.1:58151_solr
[junit4] 2> 533755 INFO
(OverseerStateUpdate-97335483077230604-127.0.0.1:58151_solr-n_0000000005)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:58151_solr
[junit4] 2> 533767 WARN (OverseerExitThread) [n:127.0.0.1:58151_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 533769 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37736_solr
[junit4] 2> 533770 INFO (OverseerExitThread) [n:127.0.0.1:58151_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000005) closing
[junit4] 2> 533772 INFO (Thread-1026) [n:127.0.0.1:58151_solr ]
o.a.s.c.OverseerNodePrioritizer prioritizing overseer nodes at
97335483077230604-127.0.0.1:58151_solr-n_0000000005 overseer designates are
[127.0.0.1:39543_solr, 127.0.0.1:58151_solr, 127.0.0.1:37736_solr]
[junit4] 2> 533773 INFO (Thread-1026) [n:127.0.0.1:58151_solr ]
o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230603-127.0.0.1:37736_solr-n_0000000006,
97335483077230599-127.0.0.1:33069_solr-n_0000000007,
97335483077230604-127.0.0.1:58151_solr-n_0000000008]
[junit4] 2> 533773 INFO (Thread-1026) [n:127.0.0.1:58151_solr ]
o.a.s.c.OverseerNodePrioritizer asking node
97335483077230603-127.0.0.1:37736_solr-n_0000000006 to come join election at
head
[junit4] 2> 533773 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230603-127.0.0.1:37736_solr-n_0000000006) starting
[junit4] 2> 533811 INFO (qtp427756095-3978) [n:127.0.0.1:37736_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoinAtHead&qt=/admin/cores&action=OVERSEEROP&electionNode=97335483077230603-127.0.0.1:37736_solr-n_0000000006&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 533811 INFO (Thread-1026) [n:127.0.0.1:58151_solr ]
o.a.s.c.OverseerNodePrioritizer asking the old first in line
97335483077230599-127.0.0.1:33069_solr-n_0000000007 to rejoin election
[junit4] 2> 533814 INFO (qtp1207892882-3961) [n:127.0.0.1:33069_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={op=rejoin&qt=/admin/cores&action=OVERSEEROP&electionNode=97335483077230599-127.0.0.1:33069_solr-n_0000000007&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 533817 INFO
(OverseerStateUpdate-97335483077230603-127.0.0.1:37736_solr-n_0000000006)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230603-127.0.0.1:37736_solr-n_0000000006"}
127.0.0.1:37736_solr
[junit4] 2> 533818 INFO
(OverseerStateUpdate-97335483077230603-127.0.0.1:37736_solr-n_0000000006)
[n:127.0.0.1:37736_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:37736_solr
[junit4] 2> 533819 WARN (OverseerExitThread) [n:127.0.0.1:37736_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 533820 INFO (OverseerExitThread) [n:127.0.0.1:37736_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230603-127.0.0.1:37736_solr-n_0000000006) closing
[junit4] 2> 533821 INFO
(zkCallback-618-thread-2-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:33069_solr
[junit4] 2> 533823 INFO
(zkCallback-618-thread-2-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000007) starting
[junit4] 2> 533830 INFO
(OverseerCollectionConfigSetProcessor-97335483077230599-127.0.0.1:33069_solr-n_0000000007)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerNodePrioritizer prioritizing
overseer nodes at 97335483077230599-127.0.0.1:33069_solr-n_0000000007 overseer
designates are [127.0.0.1:39543_solr, 127.0.0.1:58151_solr,
127.0.0.1:37736_solr]
[junit4] 2> 533830 INFO
(OverseerCollectionConfigSetProcessor-97335483077230599-127.0.0.1:33069_solr-n_0000000007)
[n:127.0.0.1:33069_solr ] o.a.s.c.OverseerNodePrioritizer sorted nodes
[97335483077230599-127.0.0.1:33069_solr-n_0000000007,
97335483077230604-127.0.0.1:58151_solr-n_0000000008,
97335483077230603-127.0.0.1:37736_solr-n_0000000009]
[junit4] 2> 533832 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000007)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Quit command received {
[junit4] 2> "operation":"quit",
[junit4] 2> "id":"97335483077230599-127.0.0.1:33069_solr-n_0000000007"}
127.0.0.1:33069_solr
[junit4] 2> 533833 INFO
(OverseerStateUpdate-97335483077230599-127.0.0.1:33069_solr-n_0000000007)
[n:127.0.0.1:33069_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:33069_solr
[junit4] 2> 533834 WARN (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer I'm exiting, but I'm still the leader
[junit4] 2> 533835 INFO (OverseerExitThread) [n:127.0.0.1:33069_solr ]
o.a.s.c.Overseer Overseer
(id=97335483077230599-127.0.0.1:33069_solr-n_0000000007) closing
[junit4] 2> 533835 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:58151_solr
[junit4] 2> 533837 INFO
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000008) starting
[junit4] 2> 543809 INFO
(TEST-OverseerRolesTest.testOverseerRole-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testOverseerRole
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=OverseerRolesTest
-Dtests.method=testOverseerRole -Dtests.seed=73D6C13450011BAB
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=ar-DZ
-Dtests.timezone=America/Miquelon -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 11.9s J1 | OverseerRolesTest.testOverseerRole <<<
[junit4] > Throwable #1: java.lang.AssertionError: Timed out waiting for
overseer state change
[junit4] > at
__randomizedtesting.SeedInfo.seed([73D6C13450011BAB:921D3CA06BB22D7A]:0)
[junit4] > at
org.apache.solr.cloud.OverseerRolesTest.waitForNewOverseer(OverseerRolesTest.java:62)
[junit4] > at
org.apache.solr.cloud.OverseerRolesTest.testOverseerRole(OverseerRolesTest.java:140)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 543813 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@473764db{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 543815 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1167398698
[junit4] 2> 543815 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@5b37d501{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 543816 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=885430483
[junit4] 2> 543816 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@649df1f4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 543817 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=456879606
[junit4] 2> 543822 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.c.Overseer Overseer
(id=97335483077230604-127.0.0.1:58151_solr-n_0000000008) closing
[junit4] 2> 543823 INFO
(OverseerStateUpdate-97335483077230604-127.0.0.1:58151_solr-n_0000000008)
[n:127.0.0.1:58151_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:58151_solr
[junit4] 2> 543826 INFO
(zkCallback-622-thread-1-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (1)
[junit4] 2> 543827 INFO
(zkCallback-622-thread-2-processing-n:127.0.0.1:37736_solr)
[n:127.0.0.1:37736_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37736_solr
[junit4] 2> 545325 WARN
(zkCallback-623-thread-1-processing-n:127.0.0.1:58151_solr)
[n:127.0.0.1:58151_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 545326 INFO (jetty-launcher-601-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 545326 INFO (jetty-launcher-601-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2ef0d7b6{/solr,null,UNAVAILABLE}
[junit4] 2> 545326 WARN
(zkCallback-618-thread-2-processing-n:127.0.0.1:33069_solr)
[n:127.0.0.1:33069_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 545326 INFO (jetty-launcher-601-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 545327 INFO (jetty-launcher-601-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5b125f11{/solr,null,UNAVAILABLE}
[junit4] 2> 545328 INFO (jetty-launcher-601-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 545331 INFO (jetty-launcher-601-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@b531f80{/solr,null,UNAVAILABLE}
[junit4] 2> 545339 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:48713 48713
[junit4] 2> 545579 INFO (Thread-984) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:48713 48713
[junit4] 2> 545579 WARN (Thread-984) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/overseer/queue-work
[junit4] 2> 13 /solr/overseer/collection-queue-work
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2> 3 /solr/overseer/queue
[junit4] 2>
[junit4] 2> 545580 INFO
(SUITE-OverseerRolesTest-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.OverseerRolesTest_73D6C13450011BAB-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=389, maxMBSortInHeap=7.384692962324628,
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=ar-DZ,
timezone=America/Miquelon
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=1,free=110034216,total=426770432
[junit4] 2> NOTE: All tests run in this JVM: [DistanceUnitsTest,
SolrSlf4jReporterTest, OpenCloseCoreStressTest, TestNumericTerms64,
TestSolrConfigHandler, TriLevelCompositeIdRoutingTest,
ClassificationUpdateProcessorIntegrationTest, JSONWriterTest,
TestSolr4Spatial2, FileUtilsTest, TestSolrCloudWithSecureImpersonation,
ConjunctionSolrSpellCheckerTest, TestCloudRecovery, MissingSegmentRecoveryTest,
TestLRUStatsCache, TestDFISimilarityFactory,
CollectionsAPIAsyncDistributedZkTest, BigEndianAscendingWordDeserializerTest,
TestManagedSchemaAPI, TestLRUCache, TestCoreContainer, QueryResultKeyTest,
TestHashPartitioner, CustomCollectionTest, TestCopyFieldCollectionResource,
TestDownShardTolerantSearch, SolrXmlInZkTest, TestReRankQParserPlugin,
DirectSolrSpellCheckerTest, AnalyticsMergeStrategyTest,
TestDistributedGrouping, SchemaVersionSpecificBehaviorTest,
CdcrReplicationHandlerTest, TestExceedMaxTermLength, TestQueryWrapperFilter,
ConvertedLegacyTest, BasicFunctionalityTest, ClusterStateUpdateTest,
TestSolrCloudSnapshots, ShardRoutingCustomTest, TestCloudSchemaless,
TestElisionMultitermQuery, DistributedFacetPivotSmallTest,
SolrIndexSplitterTest, MoreLikeThisHandlerTest, TestSystemIdResolver,
DocExpirationUpdateProcessorFactoryTest, TestSerializedLuceneMatchVersion,
TestSubQueryTransformerDistrib, TestStandardQParsers,
UpdateRequestProcessorFactoryTest, TestCharFilters, TestFieldCacheWithThreads,
DistributedQueryComponentOptimizationTest, SolrInfoMBeanTest, OverseerRolesTest]
[junit4] Completed [177/681 (1!)] on J1 in 14.68s, 1 test, 1 failure <<<
FAILURES!
[...truncated 449 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/init-core-data-001
[junit4] 2> 1195026 INFO
(SUITE-TestReplicationHandler-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 1195028 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTestRepeater
[junit4] 2> 1195028 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/collection1
[junit4] 2> 1195035 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1195038 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@13d6fffe{/solr,null,AVAILABLE}
[junit4] 2> 1195039 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@7126b91a{HTTP/1.1,[http/1.1]}{127.0.0.1:41570}
[junit4] 2> 1195039 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server Started @1199213ms
[junit4] 2> 1195040 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/collection1/data,
hostContext=/solr, hostPort=41570}
[junit4] 2> 1195040 ERROR
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1195040 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 1195040 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 1195040 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1195040 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:44:28.053Z
[junit4] 2> 1195041 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/solr.xml
[junit4] 2> 1195054 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1195059 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/.
[junit4] 2> 1195059 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1195072 WARN (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1195073 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 1195082 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1195099 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1195101 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/./collection1
[junit4] 2> 1195101 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/./collection1/data/]
[junit4] 2> 1195102 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=96.00390625,
floorSegmentMB=1.7841796875, forceMergeDeletesPctAllowed=3.5959067124676647,
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6461818743198144
[junit4] 2> 1195117 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1195117 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1195117 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1195118 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@c92d93b[collection1]
main]
[junit4] 2> 1195118 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-001/collection1/conf
[junit4] 2> 1195118 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1195118 INFO (coreLoadExecutor-3716-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1195134 INFO
(searcherExecutor-3717-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@c92d93b[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1195558 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1
[junit4] 2> 1195561 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1195562 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3142ef3{/solr,null,AVAILABLE}
[junit4] 2> 1195563 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1936a9b1{HTTP/1.1,[http/1.1]}{127.0.0.1:41147}
[junit4] 2> 1195563 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server Started @1199737ms
[junit4] 2> 1195563 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=41147}
[junit4] 2> 1195563 ERROR
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1195566 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 1195566 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 1195566 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1195566 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:44:28.579Z
[junit4] 2> 1195566 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/solr.xml
[junit4] 2> 1195578 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1195582 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/.
[junit4] 2> 1195582 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1195602 WARN (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1195608 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 1195619 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1195621 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1195622 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/./collection1
[junit4] 2> 1195623 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/./collection1/data/]
[junit4] 2> 1195624 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=96.00390625,
floorSegmentMB=1.7841796875, forceMergeDeletesPctAllowed=3.5959067124676647,
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6461818743198144
[junit4] 2> 1195637 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1195637 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1195638 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1195638 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@448f2428[collection1] main]
[junit4] 2> 1195638 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1/conf
[junit4] 2> 1195660 INFO (coreLoadExecutor-3726-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
1000ms
[junit4] 2> 1195661 INFO
(searcherExecutor-3727-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@448f2428[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1195669 INFO (qtp1949688069-12606) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0
QTime=0
[junit4] 2> 1195670 INFO (indexFetcher-3731-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1195670 INFO (indexFetcher-3731-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1195670 INFO (indexFetcher-3731-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1196096 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@1936a9b1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1196096 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=421379299
[junit4] 2> 1196098 INFO (coreCloseExecutor-3732-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@8c0cfb3
[junit4] 2> 1196098 INFO (coreCloseExecutor-3732-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 1196099 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1196099 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3142ef3{/solr,null,UNAVAILABLE}
[junit4] 2> 1196101 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1196103 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5791c3ef{/solr,null,AVAILABLE}
[junit4] 2> 1196103 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@c6dcc9{HTTP/1.1,[http/1.1]}{127.0.0.1:49373}
[junit4] 2> 1196104 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server Started @1200278ms
[junit4] 2> 1196104 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=49373}
[junit4] 2> 1196104 ERROR
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1196110 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 1196111 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 1196111 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1196111 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:44:29.124Z
[junit4] 2> 1196111 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/solr.xml
[junit4] 2> 1196118 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1196122 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/.
[junit4] 2> 1196122 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1196135 WARN (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1196141 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 1196149 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1196151 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1196152 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/./collection1
[junit4] 2> 1196153 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/./collection1/data/]
[junit4] 2> 1196154 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=96.00390625,
floorSegmentMB=1.7841796875, forceMergeDeletesPctAllowed=3.5959067124676647,
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6461818743198144
[junit4] 2> 1196210 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1196210 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1196211 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1196211 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@26704eb7[collection1] main]
[junit4] 2> 1196212 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-002/collection1/conf
[junit4] 2> 1196212 INFO (coreLoadExecutor-3739-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1196212 INFO
(searcherExecutor-3740-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@26704eb7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1196630 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/collection1
[junit4] 2> 1196633 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1196635 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@58c47c1b{/solr,null,AVAILABLE}
[junit4] 2> 1196635 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@43393bca{HTTP/1.1,[http/1.1]}{127.0.0.1:35451}
[junit4] 2> 1196635 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.e.j.s.Server Started @1200809ms
[junit4] 2> 1196635 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/collection1/data,
hostContext=/solr, hostPort=35451}
[junit4] 2> 1196636 ERROR
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1196642 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.5.0
[junit4] 2> 1196642 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 1196642 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1196642 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-24T01:44:29.655Z
[junit4] 2> 1196643 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/solr.xml
[junit4] 2> 1196649 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1196652 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/.
[junit4] 2> 1196653 INFO
(TEST-TestReplicationHandler.doTestRepeater-seed#[73D6C13450011BAB]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1196668 WARN (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1196669 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.5.0
[junit4] 2> 1196685 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1196688 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1196689 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/./collection1
[junit4] 2> 1196689 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/./collection1/data/]
[junit4] 2> 1196692 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=41, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=96.00390625,
floorSegmentMB=1.7841796875, forceMergeDeletesPctAllowed=3.5959067124676647,
segmentsPerTier=17.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6461818743198144
[junit4] 2> 1196708 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1196708 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1196710 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=34, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 1196711 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@4e224f3e[collection1] main]
[junit4] 2> 1196711 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to
use dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_73D6C13450011BAB-001/solr-instance-003/collection1/conf
[junit4] 2> 1196712 WARN (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the
/replication suffix
[junit4] 2> 1196712 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler No value set for 'pollInterval'.
Timer Task not started.
[junit4] 2> 1196712 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following
config files: schema.xml
[junit4] 2> 1196712 INFO (coreLoadExecutor-3749-thread-1) [
x:collection1] o.a.s.h.ReplicationHandler
[...truncated too long message...]
335572981678088-127.0.0.1:36360_solr-n_0000000001) closing
[junit4] 2> 2275981 INFO
(OverseerStateUpdate-97335572981678088-127.0.0.1:36360_solr-n_0000000001)
[n:127.0.0.1:36360_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:36360_solr
[junit4] 2> 2277397 WARN
(zkCallback-2681-thread-8-processing-n:127.0.0.1:59598_solr)
[n:127.0.0.1:59598_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2277398 INFO (jetty-launcher-2663-thread-7) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 2277398 INFO (jetty-launcher-2663-thread-7) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@ef0c0b5{/solr,null,UNAVAILABLE}
[junit4] 2> 2277425 WARN
(zkCallback-2683-thread-2-processing-n:127.0.0.1:53699_solr)
[n:127.0.0.1:53699_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2277425 INFO (jetty-launcher-2663-thread-5) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 2277425 INFO (jetty-launcher-2663-thread-5) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4547c33c{/solr,null,UNAVAILABLE}
[junit4] 2> 2277482 WARN
(zkCallback-2678-thread-2-processing-n:127.0.0.1:36360_solr)
[n:127.0.0.1:36360_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 2277482 INFO (jetty-launcher-2663-thread-6) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 2277483 INFO (jetty-launcher-2663-thread-6) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@53e3ac6{/solr,null,UNAVAILABLE}
[junit4] 2> 2277484 INFO
(SUITE-TestStressCloudBlindAtomicUpdates-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:60377 60377
[junit4] 2> 2277574 INFO (Thread-5049) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:60377 60377
[junit4] 2> 2277575 WARN (Thread-5049) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/aliases.json
[junit4] 2> 5 /solr/clusterprops.json
[junit4] 2> 4
/solr/configs/org.apache.solr.cloud.TestStressCloudBlindAtomicUpdates_config-set
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 5 /solr/clusterstate.json
[junit4] 2> 4 /solr/collections/test_col/state.json
[junit4] 2> 2
/solr/overseer_elect/election/97335572981678088-127.0.0.1:36360_solr-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 368 /solr/overseer/collection-queue-work
[junit4] 2> 27 /solr/overseer/queue
[junit4] 2> 8 /solr/overseer/queue-work
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 5 /solr/collections
[junit4] 2>
[junit4] 2> 2277575 INFO
(SUITE-TestStressCloudBlindAtomicUpdates-seed#[73D6C13450011BAB]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.cloud.TestStressCloudBlindAtomicUpdates_73D6C13450011BAB-001
[junit4] 2> Jan 24, 2017 2:02:30 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{long_stored_idx=PostingsFormat(name=Direct),
long_dv_idx=PostingsFormat(name=LuceneVarGapDocFreqInterval), id=FSTOrd50,
long_dv_stored_idx=PostingsFormat(name=LuceneVarGapDocFreqInterval)},
docValues:{_version_=DocValuesFormat(name=Asserting),
long_dv_idx=DocValuesFormat(name=Direct),
long_dv_stored=DocValuesFormat(name=Memory), id=DocValuesFormat(name=Memory),
long_dv=DocValuesFormat(name=Direct),
long_dv_stored_idx=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=732,
maxMBSortInHeap=5.280681373479129,
sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=ar-DZ, timezone=UCT
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=1,free=121868016,total=528482304
[junit4] 2> NOTE: All tests run in this JVM: [TestManagedResource,
TestDistributedMissingSort, HttpSolrCallGetCoreTest, ZkStateWriterTest,
TestFreeTextSuggestions, TestRequestForwarding,
OpenExchangeRatesOrgProviderTest, DocValuesMissingTest, SimpleFacetsTest,
FieldAnalysisRequestHandlerTest, TestExactSharedStatsCache,
SharedFSAutoReplicaFailoverTest, TestXmlQParserPlugin,
ShufflingReplicaListTransformerTest, TestTolerantUpdateProcessorRandomCloud,
FieldMutatingUpdateProcessorTest, OverseerStatusTest, TestReqParamsAPI,
AnalyticsQueryTest, SmileWriterTest, TestReloadAndDeleteDocs,
HdfsChaosMonkeyNothingIsSafeTest, TestExclusionRuleCollectionAccess,
CdcrBootstrapTest, BlockDirectoryTest, TestLegacyFieldCache,
TestSchemaSimilarityResource, TestLockTree, LukeRequestHandlerTest,
AtomicUpdatesTest, TestBinaryField, DeleteReplicaTest, TestZkChroot,
SegmentsInfoRequestHandlerTest, TestSolrJ, TestSolrDeletionPolicy1,
SparseHLLTest, BadComponentTest, PrimUtilsTest, TestTestInjection,
CdcrRequestHandlerTest, TestUtils, CoreAdminCreateDiscoverTest,
SmileWriterTest, InfoHandlerTest, HighlighterMaxOffsetTest, TestIndexSearcher,
TestComplexPhraseQParserPlugin, TestUseDocValuesAsStored, TestPivotHelperCode,
StressHdfsTest, RulesTest, ReplicationFactorTest, QueryParsingTest,
TestAuthenticationFramework, XmlUpdateRequestHandlerTest,
TestDelegationWithHadoopAuth, TestMergePolicyConfig, TestFieldCacheSortRandom,
TestBackupRepositoryFactory, JvmMetricsTest, OverseerTest,
TestPKIAuthenticationPlugin, TestNonDefinedSimilarityFactory, TestExportWriter,
TestExtendedDismaxParser, TestFilteredDocIdSet, SuggesterWFSTTest,
JSONWriterTest, TestBulkSchemaAPI, DistributedFacetPivotWhiteBoxTest,
TestStressUserVersions, TestSort, TestAnalyzeInfixSuggestions,
DistributedSuggestComponentTest, SuggesterTSTTest, AutoCommitTest,
RequestHandlersTest, CdcrUpdateLogTest, ConnectionReuseTest,
TermVectorComponentDistributedTest, TestRawTransformer, CleanupOldIndexTest,
TestJmxMonitoredMap, SolrIndexMetricsTest, DistributedQueueTest,
PreAnalyzedFieldTest, TestAnalyzedSuggestions, TestGroupingSearch,
TestIndexingPerformance, TestFieldCacheReopen, SolrTestCaseJ4Test,
TestCloudManagedSchema, LeaderFailoverAfterPartitionTest,
TestDeleteCollectionOnDownNodes, ConnectionManagerTest,
TestSubQueryTransformer, TestJavabinTupleStreamParser, AssignTest,
NoCacheHeaderTest, CircularListTest, TestSQLHandlerNonCloud, TestRecovery,
PingRequestHandlerTest, CollectionStateFormat2Test, BJQParserTest,
BadIndexSchemaTest, SpellPossibilityIteratorTest, TestSolrCoreParser,
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, UnloadDistributedZkTest,
ShardRoutingTest, RecoveryZkTest, FullSolrCloudDistribCmdsTest,
TestRandomFaceting, LeaderElectionTest, TestFaceting,
DistributedSpellCheckComponentTest, ZkControllerTest, TestStressReorder,
TestReload, TestStressVersions, HardAutoCommitTest, TestRangeQuery,
StatsComponentTest, SpellCheckComponentTest, SolrCmdDistributorTest,
TestFiltering, TestFunctionQuery, DirectUpdateHandlerTest, TestBadConfig,
HighlighterTest, SoftAutoCommitTest, ShowFileRequestHandlerTest,
CurrencyFieldOpenExchangeTest, CurrencyFieldXmlFileTest, SimplePostToolTest,
TestCoreDiscovery, SpellCheckCollatorTest, SuggesterFSTTest,
CoreAdminHandlerTest, DocValuesTest, SuggesterTest, TestTrie, TestCSVLoader,
WordBreakSolrSpellCheckerTest, SolrCoreCheckLockOnStartupTest,
TestPseudoReturnFields, TestAtomicUpdateErrorCases,
TestWordDelimiterFilterFactory, DirectUpdateHandlerOptimizeTest,
DefaultValueUpdateProcessorTest, StatelessScriptUpdateProcessorFactoryTest,
SortByFunctionTest, DocValuesMultiTest, DistanceFunctionTest,
DebugComponentTest, TestSurroundQueryParser, TestQueryUtils, TestWriterPerf,
TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest,
TestQueryTypes, PrimitiveFieldTypeTest, TestOmitPositions,
FileBasedSpellCheckerTest, TermsComponentTest, DocumentBuilderTest,
TestValueSourceCache, PathHierarchyTokenizerFactoryTest, TestSolrQueryParser,
FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest, LoggingHandlerTest,
RegexBoostProcessorTest, SolrPluginUtilsTest, IndexSchemaTest,
TestCollationField, TestCSVResponseWriter, MBeansHandlerTest, JsonLoaderTest,
BinaryUpdateRequestHandlerTest, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, CSVRequestHandlerTest, SearchHandlerTest,
TestLFUCache, TestSuggestSpellingConverter, DateFieldTest, DOMUtilTest,
RAMDirectoryFactoryTest, SystemInfoHandlerTest, UUIDFieldTest, TestRTGBase,
TestCursorMarkWithoutUniqueKey, TestHighlightDedupGrouping,
TestSimpleTrackingShardHandler, TestTolerantSearch,
TestEmbeddedSolrServerConstructors, TestJettySolrRunner, AliasIntegrationTest,
CollectionTooManyReplicasTest, ConcurrentDeleteAndCreateCollectionTest,
ConfigSetsAPITest, CreateCollectionCleanupTest, DeleteInactiveReplicaTest,
DistribDocExpirationUpdateProcessorTest, DistribJoinFromCollectionTest,
LeaderElectionContextKeyTest, LeaderFailureAfterFreshStartTest,
LeaderInitiatedRecoveryOnShardRestartTest, MultiThreadedOCPTest,
RemoteQueryErrorTest, SSLMigrationTest, SharedFSAutoReplicaFailoverUtilsTest,
SolrCLIZkUtilsTest, SolrCloudExampleTest, TestHdfsCloudBackupRestore,
TestMiniSolrCloudClusterSSL, TestRebalanceLeaders, TestSSLRandomization,
TestStressCloudBlindAtomicUpdates]
[junit4] Completed [651/681 (4!)] on J2 in 374.72s, 5 tests, 1 failure <<<
FAILURES!
[...truncated 62552 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
