Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19687/
Java: 64bit/jdk1.8.0_131 -XX:-UseCompressedOops -XX:+UseSerialGC
5 tests failed.
FAILED: org.apache.solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest.test
Error Message:
Could not find a healthy node to handle the request.
Stack Trace:
org.apache.solr.common.SolrException: Could not find a healthy node to handle
the request.
at
__randomizedtesting.SeedInfo.seed([E5F22A027BC4136B:6DA615D8D5387E93]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1392)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1139)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1244)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1244)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1244)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1244)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1244)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1074)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:160)
at
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:895)
at
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:858)
at
org.apache.solr.client.solrj.SolrClient.deleteByQuery(SolrClient.java:873)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.del(AbstractFullDistribZkTestBase.java:890)
at
org.apache.solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest.tryDelete(ChaosMonkeySafeLeaderWithPullReplicasTest.java:235)
at
org.apache.solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest.test(ChaosMonkeySafeLeaderWithPullReplicasTest.java:128)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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:748)
FAILED: org.apache.solr.ltr.TestLTRQParserPlugin.ltrMoreResultsThanReRankedTest
Error Message:
mismatch: '0.09271725'!='0.105360515' @ response/docs/[3]/score
Stack Trace:
java.lang.RuntimeException: mismatch: '0.09271725'!='0.105360515' @
response/docs/[3]/score
at
__randomizedtesting.SeedInfo.seed([EFF53E0E4A43BB1D:268D8F69958CECDC]:0)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:248)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:192)
at
org.apache.solr.ltr.TestLTRQParserPlugin.ltrMoreResultsThanReRankedTest(TestLTRQParserPlugin.java:94)
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:748)
FAILED:
org.apache.solr.ltr.TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder
Error Message:
mismatch: '3'!='4' @ response/docs/[0]/id
Stack Trace:
java.lang.RuntimeException: mismatch: '3'!='4' @ response/docs/[0]/id
at
__randomizedtesting.SeedInfo.seed([EFF53E0E4A43BB1D:8AB91E6E8021DCF5]:0)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:248)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:192)
at
org.apache.solr.ltr.TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder(TestParallelWeightCreation.java:45)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
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:748)
FAILED:
org.apache.solr.ltr.TestSelectiveWeightCreation.testSelectiveWeightsRequestFeaturesFromDifferentStore
Error Message:
mismatch: '3'!='4' @ response/docs/[0]/id
Stack Trace:
java.lang.RuntimeException: mismatch: '3'!='4' @ response/docs/[0]/id
at
__randomizedtesting.SeedInfo.seed([EFF53E0E4A43BB1D:B2C429CBC77FCC76]:0)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:248)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:192)
at
org.apache.solr.ltr.TestSelectiveWeightCreation.testSelectiveWeightsRequestFeaturesFromDifferentStore(TestSelectiveWeightCreation.java:230)
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:748)
FAILED: org.apache.solr.ltr.feature.TestFieldLengthFeature.testRanking
Error Message:
mismatch: '8'!='1' @ response/docs/[0]/id
Stack Trace:
java.lang.RuntimeException: mismatch: '8'!='1' @ response/docs/[0]/id
at
__randomizedtesting.SeedInfo.seed([EFF53E0E4A43BB1D:70C39790D239A4D2]:0)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:248)
at org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:192)
at
org.apache.solr.ltr.feature.TestFieldLengthFeature.testRanking(TestFieldLengthFeature.java:117)
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:748)
Build Log:
[...truncated 12610 lines...]
[junit4] Suite:
org.apache.solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest
[junit4] 2> Creating dataDir:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/init-core-data-001
[junit4] 2> 1270880 WARN
(SUITE-ChaosMonkeySafeLeaderWithPullReplicasTest-seed#[E5F22A027BC4136B]-worker)
[ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=16 numCloses=16
[junit4] 2> 1270880 INFO
(SUITE-ChaosMonkeySafeLeaderWithPullReplicasTest-seed#[E5F22A027BC4136B]-worker)
[ ] o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 1270881 INFO
(SUITE-ChaosMonkeySafeLeaderWithPullReplicasTest-seed#[E5F22A027BC4136B]-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> 1270881 INFO
(SUITE-ChaosMonkeySafeLeaderWithPullReplicasTest-seed#[E5F22A027BC4136B]-worker)
[ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system
property: /da_/
[junit4] 2> 1270882 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ChaosMonkeySafeLeaderWithPullReplicasTest Starting ChaosMonkey
test with 1 shards and 3 nodes
[junit4] 2> 1270883 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1270883 INFO (Thread-2746) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1270883 INFO (Thread-2746) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1270884 ERROR (Thread-2746) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1270983 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkTestServer start zk server on port:33971
[junit4] 2> 1270987 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1270988 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 1270988 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1270989 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1270990 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1270990 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1270990 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1270991 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1270991 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1270992 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1270992 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractZkTestCase put
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1270993 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractFullDistribZkTestBase Will use TLOG replicas unless
explicitly asked otherwise
[junit4] 2> 1271043 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/cores/collection1
[junit4] 2> 1271044 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1271044 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5da9c9d2{/da_,null,AVAILABLE}
[junit4] 2> 1271045 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@175322a8{HTTP/1.1,[http/1.1]}{127.0.0.1:39745}
[junit4] 2> 1271045 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server Started @1273018ms
[junit4] 2> 1271045 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/tempDir-001/control/data,
hostContext=/da_, hostPort=39745,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/cores}
[junit4] 2> 1271045 ERROR
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may
be missing or incomplete.
[junit4] 2> 1271046 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 7.0.0
[junit4] 2> 1271046 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1271046 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1271046 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-23T11:14:03.272Z
[junit4] 2> 1271050 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1271050 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/solr.xml
[junit4] 2> 1271068 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1271070 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33971/solr
[junit4] 2> 1271078 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1271078 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:39745_da_
[junit4] 2> 1271079 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.Overseer Overseer
(id=98011581193256964-127.0.0.1:39745_da_-n_0000000000) starting
[junit4] 2> 1271084 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39745_da_
[junit4] 2> 1271085 INFO
(zkCallback-3386-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1271116 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1271120 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1271120 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1271121 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/cores
[junit4] 2> 1271121 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39745_da_ ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 1271122 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1271123 INFO
(OverseerStateUpdate-98011581193256964-127.0.0.1:39745_da_-n_0000000000)
[n:127.0.0.1:39745_da_ ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 1272129 WARN
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 1272130 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 1272137 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1272203 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1272209 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection, trusted=true
[junit4] 2> 1272209 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.core_node1' (registry
'solr.core.control_collection.shard1.core_node1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1272209 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1272209 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/control-001/cores/collection1/data/]
[junit4] 2> 1272211 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=26, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1272359 WARN
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 1272400 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1272400 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1272401 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1272401 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1272401 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=12, maxMergeAtOnceExplicit=16, maxMergedSegmentMB=45.400390625,
floorSegmentMB=1.8447265625, forceMergeDeletesPctAllowed=14.39302509650641,
segmentsPerTier=44.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.19768477299988074
[junit4] 2> 1272402 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@28d02093[collection1] main]
[junit4] 2> 1272402 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1272402 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1272403 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1272404 INFO
(searcherExecutor-5840-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@28d02093[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1272404 INFO
(coreLoadExecutor-5839-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1568185300685946880
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:39745/da_/collection1/
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:39745/da_/collection1/ has no replicas
[junit4] 2> 1272407 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 1272408 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:39745/da_/collection1/ shard1
[junit4] 2> 1272559 INFO
(coreZkRegister-5832-thread-1-processing-n:127.0.0.1:39745_da_ x:collection1
c:control_collection) [n:127.0.0.1:39745_da_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 1272634 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1272634 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:33971/solr
ready
[junit4] 2> 1272635 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 1272635 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with
stateFormat=2
[junit4] 2> 1272677 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/cores/collection1
[junit4] 2> 1272677 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001
of type PULL
[junit4] 2> 1272678 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1272678 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5720cc51{/da_,null,AVAILABLE}
[junit4] 2> 1272678 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@664129c0{HTTP/1.1,[http/1.1]}{127.0.0.1:39633}
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server Started @1274651ms
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/tempDir-001/jetty1,
replicaType=PULL, solrconfig=solrconfig.xml, hostContext=/da_, hostPort=39633,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/cores}
[junit4] 2> 1272679 ERROR
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may
be missing or incomplete.
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 7.0.0
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1272679 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-23T11:14:04.905Z
[junit4] 2> 1272680 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1272680 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/solr.xml
[junit4] 2> 1272683 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1272684 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33971/solr
[junit4] 2> 1272687 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 1272687 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1272688 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39633_da_
[junit4] 2> 1272688 INFO
(zkCallback-3386-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1272688 INFO (zkCallback-3390-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1272688 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 1272747 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1272750 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1272750 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1272751 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/cores
[junit4] 2> 1272751 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:39633_da_ ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 1272752 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1272752 INFO
(OverseerStateUpdate-98011581193256964-127.0.0.1:39745_da_-n_0000000000)
[n:127.0.0.1:39745_da_ ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 1272854 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeCreated
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 1273764 WARN
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1273765 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 1273778 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1273871 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1273876 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 1273877 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.m.r.SolrJmxReporter
JMX monitoring for 'solr.core.collection1.shard1.core_node1' (registry
'solr.core.collection1.shard1.core_node1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1273877 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1273877 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-1-001/cores/collection1/data/]
[junit4] 2> 1273878 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=26,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1273970 WARN
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1274006 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1274006 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1274007 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=16,
maxMergedSegmentMB=45.400390625, floorSegmentMB=1.8447265625,
forceMergeDeletesPctAllowed=14.39302509650641, segmentsPerTier=44.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19768477299988074
[junit4] 2> 1274007 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@1e9b72be[collection1] main]
[junit4] 2> 1274009 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1274009 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1274010 INFO
(coreLoadExecutor-5850-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1274010 INFO
(searcherExecutor-5851-thread-1-processing-n:127.0.0.1:39633_da_ x:collection1
c:collection1) [n:127.0.0.1:39633_da_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1e9b72be[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1274011 INFO
(coreZkRegister-5845-thread-1-processing-n:127.0.0.1:39633_da_ x:collection1
c:collection1) [n:127.0.0.1:39633_da_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController collection1 starting background replication
from leader
[junit4] 2> 1274011 INFO
(coreZkRegister-5845-thread-1-processing-n:127.0.0.1:39633_da_ x:collection1
c:collection1) [n:127.0.0.1:39633_da_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ReplicateFromLeader Will start replication from leader
with poll interval: 0:0:7
[junit4] 2> 1274011 INFO
(coreZkRegister-5845-thread-1-processing-n:127.0.0.1:39633_da_ x:collection1
c:collection1) [n:127.0.0.1:39633_da_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
7000ms
[junit4] 2> 1274011 WARN
(coreZkRegister-5845-thread-1-processing-n:127.0.0.1:39633_da_ x:collection1
c:collection1) [n:127.0.0.1:39633_da_ c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler SolrCloud is enabled for core
collection1 but so is old-style replication. Make sure you intend this
behavior, it usually indicates a mis-configuration. Master setting is false and
slave setting is true
[junit4] 2> 1274325 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/cores/collection1
[junit4] 2> 1274325 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001
of type PULL
[junit4] 2> 1274326 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1274327 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@f711d85{/da_,null,AVAILABLE}
[junit4] 2> 1274327 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@34f82c7f{HTTP/1.1,[http/1.1]}{127.0.0.1:34139}
[junit4] 2> 1274327 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server Started @1276300ms
[junit4] 2> 1274327 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/tempDir-001/jetty2,
replicaType=PULL, solrconfig=solrconfig.xml, hostContext=/da_, hostPort=34139,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/cores}
[junit4] 2> 1274327 ERROR
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may
be missing or incomplete.
[junit4] 2> 1274328 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 7.0.0
[junit4] 2> 1274328 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1274328 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1274328 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-23T11:14:06.554Z
[junit4] 2> 1274329 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1274329 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/solr.xml
[junit4] 2> 1274332 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1274333 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33971/solr
[junit4] 2> 1274338 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 1274338 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1274339 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34139_da_
[junit4] 2> 1274339 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1274339 INFO (zkCallback-3390-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1274339 INFO
(zkCallback-3386-thread-1-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1274339 INFO
(zkCallback-3402-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 1274382 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1274384 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1274384 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1274385 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/cores
[junit4] 2> 1274385 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:34139_da_ ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 1274386 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1274387 INFO
(OverseerStateUpdate-98011581193256964-127.0.0.1:39745_da_-n_0000000000)
[n:127.0.0.1:39745_da_ ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 1274489 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1274489 INFO
(zkCallback-3402-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 1275399 WARN
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1275400 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 1275434 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1275501 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1275507 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 1275507 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.m.r.SolrJmxReporter
JMX monitoring for 'solr.core.collection1.shard1.core_node2' (registry
'solr.core.collection1.shard1.core_node2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1275507 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1275507 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-2-001/cores/collection1/data/]
[junit4] 2> 1275509 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=26,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1275608 WARN
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1275646 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1275646 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1275647 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=16,
maxMergedSegmentMB=45.400390625, floorSegmentMB=1.8447265625,
forceMergeDeletesPctAllowed=14.39302509650641, segmentsPerTier=44.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19768477299988074
[junit4] 2> 1275647 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@53b53b42[collection1] main]
[junit4] 2> 1275649 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1275649 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1275649 INFO
(coreLoadExecutor-5862-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1275650 INFO
(coreZkRegister-5857-thread-1-processing-n:127.0.0.1:34139_da_ x:collection1
c:collection1) [n:127.0.0.1:34139_da_ c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ZkController collection1 starting background replication
from leader
[junit4] 2> 1275650 INFO
(coreZkRegister-5857-thread-1-processing-n:127.0.0.1:34139_da_ x:collection1
c:collection1) [n:127.0.0.1:34139_da_ c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.c.ReplicateFromLeader Will start replication from leader
with poll interval: 0:0:7
[junit4] 2> 1275650 INFO
(searcherExecutor-5863-thread-1-processing-n:127.0.0.1:34139_da_ x:collection1
c:collection1) [n:127.0.0.1:34139_da_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@53b53b42[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1275651 INFO
(coreZkRegister-5857-thread-1-processing-n:127.0.0.1:34139_da_ x:collection1
c:collection1) [n:127.0.0.1:34139_da_ c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of
7000ms
[junit4] 2> 1275651 WARN
(coreZkRegister-5857-thread-1-processing-n:127.0.0.1:34139_da_ x:collection1
c:collection1) [n:127.0.0.1:34139_da_ c:collection1 s:shard1 r:core_node2
x:collection1] o.a.s.h.ReplicationHandler SolrCloud is enabled for core
collection1 but so is old-style replication. Make sure you intend this
behavior, it usually indicates a mis-configuration. Master setting is false and
slave setting is true
[junit4] 2> 1275962 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/cores/collection1
[junit4] 2> 1275963 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001
of type TLOG
[junit4] 2> 1275963 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1275964 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e635a32{/da_,null,AVAILABLE}
[junit4] 2> 1275964 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@529c47d7{HTTP/1.1,[http/1.1]}{127.0.0.1:42791}
[junit4] 2> 1275964 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.e.j.s.Server Started @1277937ms
[junit4] 2> 1275964 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/tempDir-001/jetty3,
replicaType=TLOG, solrconfig=solrconfig.xml, hostContext=/da_, hostPort=42791,
coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/cores}
[junit4] 2> 1275964 ERROR
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may
be missing or incomplete.
[junit4] 2> 1275965 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 7.0.0
[junit4] 2> 1275965 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 1275965 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1275965 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-23T11:14:08.191Z
[junit4] 2> 1275966 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 0x15c350388e6000d, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 1275966 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1275966 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/solr.xml
[junit4] 2> 1275969 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1275970 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:33971/solr
[junit4] 2> 1275974 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 1275975 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1275975 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42791_da_
[junit4] 2> 1275976 INFO
(zkCallback-3386-thread-2-processing-n:127.0.0.1:39745_da_)
[n:127.0.0.1:39745_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1275976 INFO
(zkCallback-3408-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1275976 INFO (zkCallback-3390-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1275976 INFO
(zkCallback-3402-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1275976 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 1276013 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1276016 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1276016 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1276017 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/cores
[junit4] 2> 1276017 INFO
(TEST-ChaosMonkeySafeLeaderWithPullReplicasTest.test-seed#[E5F22A027BC4136B])
[n:127.0.0.1:42791_da_ ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 1276018 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1276018 INFO
(OverseerStateUpdate-98011581193256964-127.0.0.1:39745_da_-n_0000000000)
[n:127.0.0.1:39745_da_ ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 1276142 INFO
(zkCallback-3396-thread-1-processing-n:127.0.0.1:39633_da_)
[n:127.0.0.1:39633_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 1276142 INFO
(zkCallback-3408-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 1276142 INFO
(zkCallback-3402-thread-1-processing-n:127.0.0.1:34139_da_)
[n:127.0.0.1:34139_da_ ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 1277032 WARN
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1277033 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 1277047 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1277124 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1277130 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 1277130 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.m.r.SolrJmxReporter
JMX monitoring for 'solr.core.collection1.shard1.core_node3' (registry
'solr.core.collection1.shard1.core_node3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@fe591fa
[junit4] 2> 1277130 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1277130 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/cores/collection1],
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeySafeLeaderWithPullReplicasTest_E5F22A027BC4136B-001/shard-3-001/cores/collection1/data/]
[junit4] 2> 1277131 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=26,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 1277400 WARN
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 1277439 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 1277439 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1277440 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1277440 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 1277441 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=12, maxMergeAtOnceExplicit=16,
maxMergedSegmentMB=45.400390625, floorSegmentMB=1.8447265625,
forceMergeDeletesPctAllowed=14.39302509650641, segmentsPerTier=44.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19768477299988074
[junit4] 2> 1277441 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@156e15e9[collection1] main]
[junit4] 2> 1277442 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1277442 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1277442 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1277443 INFO
(searcherExecutor-5875-thread-1-processing-n:127.0.0.1:42791_da_ x:collection1
c:collection1) [n:127.0.0.1:42791_da_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@156e15e9[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1277443 INFO
(coreLoadExecutor-5874-thread-1-processing-n:127.0.0.1:42791_da_)
[n:127.0.0.1:42791_da_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1568185305969721344
[junit4] 2> 1277446 INFO
(coreZkRegister-5869-thread-1-processing-n:127.0.0.1:42791_da_ x:collection1
c:collection1) [n:127.0.0.1:42791_da_ c:collection1 s:shard1 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 1277446 INFO
(coreZkRegister-5869-thread-1-processing-n:127.0.0.1:42791_da_ x:collection1
c:collection1) [n:127.0.0.1:42791_da_ c:collection1 s:shard1 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 1277446 INFO (coreZkRegister-5869-th
[...truncated too long message...]
junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 12925 INFO (qtp1907198971-183) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/query
params={q=*:*&indent=on&fl=*,score&rows=4&wt=json&rq={!ltr+reRankDocs%3D10+model%3Dexternalmodel+efi.user_query%3Dw3}}
hits=5 status=0 QTime=5
[junit4] 2> 12926 ERROR
(TEST-TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder-seed#[EFF53E0E4A43BB1D])
[ ] o.a.s.u.RestTestBase query failed JSON validation. error=mismatch:
'3'!='4' @ response/docs/[0]/id
[junit4] 2> expected =/response/docs/[0]/id=='3'
[junit4] 2> response = {
[junit4] 2> "responseHeader":{
[junit4] 2> "status":0,
[junit4] 2> "QTime":5,
[junit4] 2> "params":{
[junit4] 2> "q":"*:*",
[junit4] 2> "indent":"on",
[junit4] 2> "fl":"*,score",
[junit4] 2> "rows":"4",
[junit4] 2> "wt":"json",
[junit4] 2> "rq":"{!ltr reRankDocs=10 model=externalmodel
efi.user_query=w3}"}},
[junit4] 2>
"response":{"numFound":5,"start":0,"maxScore":0.36707595,"docs":[
[junit4] 2> {
[junit4] 2> "id":"4",
[junit4] 2> "title":"w3 w3",
[junit4] 2> "description":"w4",
[junit4] 2> "popularity":4,
[junit4] 2> "_version_":1568186514361286656,
[junit4] 2> "score":0.36707595},
[junit4] 2> {
[junit4] 2> "id":"3",
[junit4] 2> "title":"w3",
[junit4] 2> "description":"w3",
[junit4] 2> "popularity":3,
[junit4] 2> "_version_":1568186514357092352,
[junit4] 2> "score":0.33873552},
[junit4] 2> {
[junit4] 2> "id":"1",
[junit4] 2> "title":"w1 w3",
[junit4] 2> "description":"w1",
[junit4] 2> "popularity":1,
[junit4] 2> "_version_":1568186514323537920,
[junit4] 2> "score":0.2545195},
[junit4] 2> {
[junit4] 2> "id":"2",
[junit4] 2> "title":"w2",
[junit4] 2> "description":"w2",
[junit4] 2> "popularity":2,
[junit4] 2> "_version_":1568186514348703744,
[junit4] 2> "score":0.0}]
[junit4] 2> }}
[junit4] 2>
[junit4] 2> request =
/query?q=*%3A*&fl=*%2Cscore&rows=4&rq=%7B%21ltr+reRankDocs%3D10+model%3Dexternalmodel+efi.user_query%3Dw3%7D&wt=json&indent=on
[junit4] 2>
[junit4] 2> 12927 INFO
(TEST-TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder-seed#[EFF53E0E4A43BB1D])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
testLTRScoringQueryParallelWeightCreationResultOrder
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestParallelWeightCreation
-Dtests.method=testLTRScoringQueryParallelWeightCreationResultOrder
-Dtests.seed=EFF53E0E4A43BB1D -Dtests.multiplier=3 -Dtests.slow=true
-Dtests.locale=en-IE -Dtests.timezone=America/Knox_IN -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] ERROR 1.07s J1 |
TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder
<<<
[junit4] > Throwable #1: java.lang.RuntimeException: mismatch: '3'!='4' @
response/docs/[0]/id
[junit4] > at
__randomizedtesting.SeedInfo.seed([EFF53E0E4A43BB1D:8AB91E6E8021DCF5]:0)
[junit4] > at
org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:248)
[junit4] > at
org.apache.solr.util.RestTestBase.assertJQ(RestTestBase.java:192)
[junit4] > at
org.apache.solr.ltr.TestParallelWeightCreation.testLTRScoringQueryParallelWeightCreationResultOrder(TestParallelWeightCreation.java:45)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 12941 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@4fb35c21{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 12941 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=403424856
[junit4] 2> 12942 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 12942 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 12942 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 12942 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 12943 INFO (coreCloseExecutor-155-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@52469cc0
[junit4] 2> 12945 INFO (coreCloseExecutor-155-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1380359360
[junit4] 2> 12954 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@232a4eec{/solr,null,UNAVAILABLE}
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1466758092
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 12956 INFO
(SUITE-TestParallelWeightCreation-seed#[EFF53E0E4A43BB1D]-worker) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 12957 INFO (coreCloseExecutor-157-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@3e90e2b0
[junit4] 2> 12958 INFO (coreCloseExecutor-157-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.collection1, tag=1049682608
[junit4] 2> NOTE: leaving temporary files on disk at:
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/contrib/solr-ltr/test/J1/temp/solr.ltr.TestParallelWeightCreation_EFF53E0E4A43BB1D-001
[junit4] 2> May 23, 2017 11:33:22 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=false): {}, locale=en-IE,
timezone=America/Knox_IN
[junit4] 2> NOTE: Linux 4.8.0-52-generic amd64/Oracle Corporation
1.8.0_131 (64-bit)/cpus=8,threads=1,free=355634712,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestValueFeature,
TestEdisMaxSolrFeature, TestUserTermScoreWithQ, TestLTRQParserExplain,
TestOriginalScoreFeature, TestParallelWeightCreation]
[junit4] Completed [30/33 (4!)] on J1 in 11.19s, 2 tests, 1 error <<<
FAILURES!
[...truncated 36962 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
