Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-5.4/11/
1 tests failed.
FAILED:
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([978B2AF96872E167:4901448453D08394]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:175)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:136)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:131)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:831)
at
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR(LeaderInitiatedRecoveryOnShardRestartTest.java:104)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
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:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
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:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11303 lines...]
[junit4] Suite:
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/init-core-data-001
[junit4] 2> 2729892 INFO
(SUITE-LeaderInitiatedRecoveryOnShardRestartTest-seed#[978B2AF96872E167]-worker)
[ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system
property: /
[junit4] 2> 2729895 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2729896 INFO (Thread-18470) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2729896 INFO (Thread-18470) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2729996 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkTestServer start zk server on port:37391
[junit4] 2> 2729996 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2729997 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2729999 INFO (zkCallback-1331-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@73f8184f
name:ZooKeeperConnection Watcher:127.0.0.1:37391 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2729999 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2730000 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2730000 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 2730003 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2730003 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2730004 INFO (zkCallback-1332-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3920eba3
name:ZooKeeperConnection Watcher:127.0.0.1:37391/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2730004 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2730004 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2730004 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 2730006 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 2730007 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 2730008 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 2730010 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 2730010 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 2730012 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 2730012 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 2730014 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2730014 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2730016 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 2730016 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 2730017 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 2730018 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 2730019 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 2730019 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 2730021 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 2730021 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 2730023 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2730023 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 2730024 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2730024 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2730026 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 2730026 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 2730027 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 2730028 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 2730320 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1
[junit4] 2> 2730321 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 2730323 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7ae6e8b6{/,null,AVAILABLE}
[junit4] 2> 2730323 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.ServerConnector Started
ServerConnector@7c68df11{HTTP/1.1}{127.0.0.1:33219}
[junit4] 2> 2730323 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.Server Started @2733719ms
[junit4] 2> 2730323 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores,
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/tempDir-001/control/data,
hostPort=33219}
[junit4] 2> 2730324 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 2730324 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001'
[junit4] 2> 2730324 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
(NoInitialContextEx)
[junit4] 2> 2730324 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
find system property or JNDI)
[junit4] 2> 2730324 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2730325 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2730326 INFO (zkCallback-1333-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6ee18d2d
name:ZooKeeperConnection Watcher:127.0.0.1:37391/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2730326 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2730326 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2730327 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2730328 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/solr.xml
[junit4] 2> 2730342 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores
[junit4] 2> 2730342 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer New CoreContainer 1187170167
[junit4] 2> 2730342 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001]
[junit4] 2> 2730342 WARN
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/lib
[junit4] 2> 2730342 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37391/solr
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 2730344 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2730345 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2730346 INFO (zkCallback-1335-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7da649eb
name:ZooKeeperConnection Watcher:127.0.0.1:37391 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2730346 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2730347 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2730348 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2730349 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@d8558ec name:ZooKeeperConnection
Watcher:127.0.0.1:37391/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2730350 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2730351 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 2730352 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 2730355 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 2730357 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 2730358 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 2730360 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 2730361 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 2730362 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 2730364 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 2730365 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:33219_
[junit4] 2> 2730365 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:33219_
[junit4] 2> 2730366 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 2730368 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 2730369 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2730369 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/94994105589497860-127.0.0.1:33219_-n_0000000000
[junit4] 2> 2730369 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:33219_
[junit4] 2> 2730370 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 2730371 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer Overseer
(id=94994105589497860-127.0.0.1:33219_-n_0000000000) starting
[junit4] 2> 2730373 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 2730378 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 2730379 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 2730379 INFO
(OverseerCollectionConfigSetProcessor-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 2730379 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 2730393 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 2730394 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2730394 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores
[junit4] 2> 2730395 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{shard=, transient=false, config=solrconfig.xml, schema=schema.xml,
loadOnStartup=true, collection=control_collection, coreNodeName=,
name=collection1, dataDir=data/, configSetProperties=configsetprops.json,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1}
[junit4] 2> 2730396 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/
[junit4] 2> 2730396 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2730396 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1
[junit4] 2> 2730397 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:33219_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 2730397 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 2730397 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 2730398 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:33219_",
[junit4] 2> "base_url":"http://127.0.0.1:33219";,
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down"} current state version: 0
[junit4] 2> 2730398 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 2730399 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:33219_",
[junit4] 2> "base_url":"http://127.0.0.1:33219";,
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down"}
[junit4] 2> 2730399 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 2730399 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2730401 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 1)
[junit4] 2> 2731399 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 2731399 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 2731400 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 2731400 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 2731400 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 2731401 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1'
[junit4] 2> 2731401 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2731401 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 2731403 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 2731409 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 2731424 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 5.4.0
[junit4] 2> 2731452 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 2731459 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2731726 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2731734 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 2731736 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 2731744 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 2731747 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 2731750 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 2731751 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 2731751 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 2731751 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 2731752 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 2731752 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 2731753 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1
[junit4] 2> 2731753 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 2731753 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 2731753 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1],
dataDir=[null]
[junit4] 2> 2731753 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@592dc527
[junit4] 2> 2731754 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data
[junit4] 2> 2731754 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data/index/
[junit4] 2> 2731754 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 2731754 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data/index
[junit4] 2> 2731754 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=10, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=8.9189453125,
floorSegmentMB=0.5751953125, forceMergeDeletesPctAllowed=4.994656391226272,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.639023521237896
[junit4] 2> 2731755 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@73633b5e
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77ced380),segFN=segments_1,generation=1}
[junit4] 2> 2731755 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2731755 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data/
[junit4] 2> 2731756 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-explicit"
[junit4] 2> 2731759 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2731760 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 2731760 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating
implicit default
[junit4] 2> 2731760 WARN
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 2731762 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2731764 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2731765 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2731766 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 2731769 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/segments,/admin/ping,/admin/logging,/admin/system,/update/json/docs,/get,/schema,/replication,/update,/admin/file,/admin/luke,/admin/plugins,/config,/update/csv,/admin/properties,standard,/admin/threads,/admin/mbeans,/dump,/update/json
[junit4] 2> 2731771 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 2731771 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 2731771 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2731772 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2731772 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2731772 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@46c38031
[junit4] 2> 2731773 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@73633b5e
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@77ced380),segFN=segments_1,generation=1}
[junit4] 2> 2731773 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 2731773 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@2b5ba797[collection1] main
[junit4] 2> 2731773 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 2731774 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 2731774 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the
RestManager with znodeBase: /configs/conf1
[junit4] 2> 2731774 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 2731774 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 2731774 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2731775 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 2731775 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 2731775 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 2731775 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2731775 INFO
(searcherExecutor-5831-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@2b5ba797[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2731776 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 2731776 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version
buckets from index
[junit4] 2> 2731776 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket
highest value from index
[junit4] 2> 2731776 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1519905691402240000
[junit4] 2> 2731778 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version
1519905691402240000
[junit4] 2> 2731778 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 2731778 INFO
(coreLoadExecutor-5830-thread-1-processing-n:127.0.0.1:33219_)
[n:127.0.0.1:33219_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 2731779 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:http://127.0.0.1:33219
collection:control_collection shard:shard1
[junit4] 2> 2731779 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 2731783 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.LeaderElector
Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/94994105589497860-core_node1-n_0000000000
[junit4] 2> 2731783 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
[junit4] 2> 2731785 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2731785 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
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> 2731785 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 2731785 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:33219/collection1/
[junit4] 2> 2731785 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 2731785 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:33219/collection1/ has no replicas
[junit4] 2> 2731786 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 2731788 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
[junit4] 2> 2731790 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
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:33219/collection1/ shard1
[junit4] 2> 2731791 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:33219";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 2731893 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 1)
[junit4] 2> 2731898 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2731899 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2731900 INFO (zkCallback-1338-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@409447bd
name:ZooKeeperConnection Watcher:127.0.0.1:37391/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2731900 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2731900 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2731900 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 2731902 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause
connection loss:false
[junit4] 2> 2731941 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:33219/collection1/ and leader is
http://127.0.0.1:33219/collection1/
[junit4] 2> 2731941 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:33219
[junit4] 2> 2731942 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 2731942 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 2731942 INFO
(coreZkRegister-5824-thread-1-processing-c:control_collection
n:127.0.0.1:33219_ r:core_node1 s:shard1 x:collection1) [n:127.0.0.1:33219_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 2731943 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:33219_",
[junit4] 2> "base_url":"http://127.0.0.1:33219";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 2731944 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "collection":"control_collection",
[junit4] 2> "node_name":"127.0.0.1:33219_",
[junit4] 2> "base_url":"http://127.0.0.1:33219";,
[junit4] 2> "shard":"shard1",
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"}
[junit4] 2> 2732046 INFO (zkCallback-1338-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 1)
[junit4] 2> 2732046 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 1)
[junit4] 2> 2732188 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores/collection1
[junit4] 2> 2732188 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001
[junit4] 2> 2732189 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 2732191 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@197929ac{/,null,AVAILABLE}
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.ServerConnector Started
ServerConnector@5ce74fac{HTTP/1.1}{127.0.0.1:40054}
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.e.j.s.Server Started @2735588ms
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
hostPort=40054,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores,
solrconfig=solrconfig.xml,
solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/tempDir-001/jetty1}
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@7b3cb2c6
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001'
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
(NoInitialContextEx)
[junit4] 2> 2732192 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
find system property or JNDI)
[junit4] 2> 2732193 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2732193 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2732194 INFO (zkCallback-1339-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@8c8c591 name:ZooKeeperConnection
Watcher:127.0.0.1:37391/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 2732194 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2732195 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2732196 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 2732196 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/solr.xml
[junit4] 2> 2732211 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores
[junit4] 2> 2732211 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer New CoreContainer 1118430221
[junit4] 2> 2732211 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001]
[junit4] 2> 2732211 WARN
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/lib
[junit4] 2> 2732211 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout :
90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost :
20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize :
2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy :
false,useRetries : false,
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:37391/solr
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 2732213 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 2732214 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2732216 INFO (zkCallback-1341-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@25d5d8db
name:ZooKeeperConnection Watcher:127.0.0.1:37391 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2732216 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2732216 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 2732219 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 2732220 INFO
(zkCallback-1342-thread-1-processing-n:127.0.0.1:40054_) [n:127.0.0.1:40054_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@40ffa68a
name:ZooKeeperConnection Watcher:127.0.0.1:37391/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 2732220 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 2732225 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 2733230 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40054_
[junit4] 2> 2733230 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:40054_
[junit4] 2> 2733231 INFO (zkCallback-1338-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 2733231 INFO
(zkCallback-1342-thread-1-processing-n:127.0.0.1:40054_) [n:127.0.0.1:40054_
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 2733232 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ZkStateReader A live node change: WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes, has occurred - updating... (live
nodes size: 1)
[junit4] 2> 2733234 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 2733234 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/94994105589497864-127.0.0.1:40054_-n_0000000001
[junit4] 2> 2733235 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/94994105589497860-127.0.0.1:33219_-n_0000000000 to
know if I could be the leader
[junit4] 2> 2733244 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 2733244 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 2733245 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores
[junit4] 2> 2733246 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{transient=false, shard=, configSetProperties=configsetprops.json,
loadOnStartup=true, schema=schema.xml, coreNodeName=, dataDir=data/,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores/collection1,
name=collection1, collection=collection1,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores/collection1/,
config=solrconfig.xml}
[junit4] 2> 2733246 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores/collection1/
[junit4] 2> 2733246 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 2733247 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1
[junit4] 2> 2733247 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:40054_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 2733247 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 2733247 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 2733249 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:40054_",
[junit4] 2> "base_url":"http://127.0.0.1:40054";,
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down"} current state version: 3
[junit4] 2> 2733249 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "collection":"collection1",
[junit4] 2> "node_name":"127.0.0.1:40054_",
[junit4] 2> "base_url":"http://127.0.0.1:40054";,
[junit4] 2> "shard":null,
[junit4] 2> "operation":"state",
[junit4] 2> "numShards":"1",
[junit4] 2> "roles":null,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"down"}
[junit4] 2> 2733249 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController look
for our core node name
[junit4] 2> 2733250 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 2733250 INFO
(OverseerStateUpdate-94994105589497860-127.0.0.1:33219_-n_0000000000)
[n:127.0.0.1:33219_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 2733352 INFO
(zkCallback-1342-thread-1-processing-n:127.0.0.1:40054_) [n:127.0.0.1:40054_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 2733352 INFO
(zkCallback-1336-thread-1-processing-n:127.0.0.1:33219_) [n:127.0.0.1:33219_
] o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 2733352 INFO (zkCallback-1338-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: WatchedEvent
state:SyncConnected type:NodeDataChanged path:/clusterstate.json, has occurred
- updating... (live nodes size: 2)
[junit4] 2> 2734251 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController waiting
to find shard id in clusterstate for collection1
[junit4] 2> 2734251 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController Check
for collection zkNode:collection1
[junit4] 2> 2734251 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 2734251 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader Load
collection config from:/collections/collection1
[junit4] 2> 2734252 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.c.ZkStateReader
path=/collections/collection1 configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 2734252 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001/shard-1-001/cores/collection1'
[junit4] 2> 2734252 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 2734252 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrResourceLoader
solr home defaulted to 'solr/' (could not find system property or JNDI)
[junit4] 2> 2734254 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.Config loaded config
solrconfig.xml with version 0
[junit4] 2> 2734259 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrConfig current
version of requestparams : -1
[junit4] 2> 2734273 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 5.4.0
[junit4] 2> 2734301 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.c.SolrConfig Loaded
SolrConfig: solrconfig.xml
[junit4] 2> 2734308 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 2734586 INFO
(coreLoadExecutor-5841-thread-1-processing-n:127.0.0.1:40054_)
[n:127.0.0.1:40054_ c:collection1 x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 2734594 INFO (cor
[...truncated too long message...]
AVAILABLE}
[junit4] 2> 3148090 INFO
(TEST-LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR-seed#[978B2AF96872E167])
[n:127.0.0.1:35848_ c:all_in_lir s:shard1 r:core_node3
x:all_in_lir_shard1_replica2] o.a.s.c.ZkTestServer connecting to
127.0.0.1:37391 37391
[junit4] 2> 3148257 INFO (Thread-18470) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:37391 37391
[junit4] 2> 3148259 WARN (Thread-18470) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/aliases.json
[junit4] 2> 10 /solr/configs/conf1
[junit4] 2> 10 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/clusterstate.json
[junit4] 2> 5
/solr/overseer_elect/election/94994105589497860-127.0.0.1:33219_-n_0000000000
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94994105589497880-core_node2-n_0000000006
[junit4] 2> 2
/solr/overseer_elect/election/94994105589497880-127.0.0.1:35443_-n_0000000007
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 11 /solr/collections
[junit4] 2> 5 /solr/live_nodes
[junit4] 2> 3 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/overseer/queue
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=LeaderInitiatedRecoveryOnShardRestartTest
-Dtests.method=testRestartWithAllInLIR -Dtests.seed=978B2AF96872E167
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=ar_SD -Dtests.timezone=Africa/Kampala -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 418s J1 |
LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR <<<
[junit4] > Throwable #1: java.lang.AssertionError: There are still nodes
recoverying - waited for 330 seconds
[junit4] > at
__randomizedtesting.SeedInfo.seed([978B2AF96872E167:4901448453D08394]:0)
[junit4] > at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:175)
[junit4] > at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:136)
[junit4] > at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:131)
[junit4] > at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:831)
[junit4] > at
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR(LeaderInitiatedRecoveryOnShardRestartTest.java:104)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:964)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:939)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 3148263 INFO
(SUITE-LeaderInitiatedRecoveryOnShardRestartTest-seed#[978B2AF96872E167]-worker)
[n:127.0.0.1:35848_ c:all_in_lir s:shard1 r:core_node3
x:all_in_lir_shard1_replica2] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build/solr-core/test/J1/temp/solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest_978B2AF96872E167-001
[junit4] 2> Dec 07, 2015 1:37:17 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene54): {},
docValues:{}, sim=DefaultSimilarity, locale=ar_SD, timezone=Africa/Kampala
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.7.0_80 (64-bit)/cpus=4,threads=1,free=159289408,total=524288000
[junit4] 2> NOTE: All tests run in this JVM: [DistributedVersionInfoTest,
TestNonDefinedSimilarityFactory, TestSerializedLuceneMatchVersion,
NumericFieldsTest, BitVectorTest, SpellPossibilityIteratorTest,
TestCopyFieldCollectionResource, MigrateRouteKeyTest,
BigEndianAscendingWordDeserializerTest, TestBlobHandler,
TestLeaderInitiatedRecoveryThread, ShardRoutingTest, TermsComponentTest,
TestWordDelimiterFilterFactory, SolrPluginUtilsTest, TestSolrDynamicMBean,
TestBM25SimilarityFactory, DeleteReplicaTest, TestDFRSimilarityFactory,
TestSolrCloudWithKerberosAlt, TestDistributedStatsComponentCardinality,
SoftAutoCommitTest, TestJettySolrRunner, UpdateRequestProcessorFactoryTest,
HdfsChaosMonkeyNothingIsSafeTest, SmileWriterTest, TestDistributedMissingSort,
TestCrossCoreJoin, TestOverriddenPrefixQueryForCustomFieldType,
TestHashPartitioner, TestFieldTypeResource, TestStressUserVersions,
TestRestManager, HdfsNNFailoverTest, TestQuerySenderListener, BadCopyFieldTest,
TestDynamicFieldResource, FullHLLTest, SuggestComponentTest,
AddBlockUpdateTest, HighlighterTest, TestStandardQParsers,
SimpleMLTQParserTest, HdfsBasicDistributedZk2Test,
TestManagedSchemaFieldTypeResource, TestCollationFieldDocValues, DocValuesTest,
SolrInfoMBeanTest, BufferStoreTest, LoggingHandlerTest,
TestManagedSchemaFieldResource, RestartWhileUpdatingTest, ZkControllerTest,
SpellCheckCollatorTest, ChaosMonkeySafeLeaderTest, TestStressVersions,
SecurityConfHandlerTest, ZkSolrClientTest, TestConfigSetsAPIZkFailure,
UUIDUpdateProcessorFallbackTest, DistributedTermsComponentTest,
TestSolrCoreProperties, TestExpandComponent, TimeZoneUtilsTest,
DistributedFacetPivotLongTailTest, TestFreeTextSuggestions,
SolrIndexSplitterTest, TestSurroundQueryParser,
PKIAuthenticationIntegrationTest, ShardRoutingCustomTest, TestExactStatsCache,
DOMUtilTest, TestLFUCache, MinimalSchemaTest, SimplePostToolTest,
TestSolr4Spatial2, TestSimpleQParserPlugin, SolrCmdDistributorTest,
TestAnalyzeInfixSuggestions, UniqFieldsUpdateProcessorFactoryTest,
CSVRequestHandlerTest, RequestLoggingTest, TestSortingResponseWriter,
DistribDocExpirationUpdateProcessorTest, TestLMJelinekMercerSimilarityFactory,
SolrTestCaseJ4Test, BasicDistributedZkTest, BasicDistributedZk2Test,
UnloadDistributedZkTest, CollectionsAPIDistributedZkTest,
FullSolrCloudDistribCmdsTest, TestZkChroot, TestRandomDVFaceting,
TestDistributedGrouping, DistributedSpellCheckComponentTest, TestReload,
TestCoreContainer, SimpleFacetsTest, SolrCoreTest, SpellCheckComponentTest,
PeerSyncTest, BadIndexSchemaTest, ConvertedLegacyTest, TestFiltering,
BasicFunctionalityTest, DirectUpdateHandlerTest, TestIndexSearcher,
CurrencyFieldOpenExchangeTest, AnalysisAfterCoreReloadTest,
SignatureUpdateProcessorFactoryTest, SuggesterFSTTest, SolrRequestParserTest,
TestStressLucene, TestTrie, PolyFieldTest, SchemaVersionSpecificBehaviorTest,
TestPseudoReturnFields, TestUpdate, DirectUpdateHandlerOptimizeTest,
SortByFunctionTest, DocValuesMultiTest, TestSolrDeletionPolicy1,
DebugComponentTest, LukeRequestHandlerTest, TestReversedWildcardFilterFactory,
TestQueryTypes, FileBasedSpellCheckerTest, DocumentBuilderTest,
TermVectorComponentTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest,
FastVectorHighlighterTest, RegexBoostProcessorTest, TestCollationField,
MBeansHandlerTest, TestPartialUpdateDeduplication, TestComponentsName,
TestBinaryResponseWriter, TestSolrIndexConfig, CopyFieldTest,
SolrIndexConfigTest, TestSolrDeletionPolicy2, MultiTermTest, SampleTest,
TestDocSet, TestBinaryField, TestSearchPerf, TestConfig,
ExternalFileFieldSortTest, DirectSolrConnectionTest, NotRequiredUniqueKeyTest,
TestPhraseSuggestions, TestCharFilters, TestCodecSupport,
TestSweetSpotSimilarityFactory, TestLMDirichletSimilarityFactory,
TestIBSimilarityFactory, TestFastOutputStream, ScriptEngineTest,
OpenExchangeRatesOrgProviderTest, TestFastLRUCache, DateMathParserTest,
ChaosMonkeyNothingIsSafeTest, TestHighlightDedupGrouping, TestTolerantSearch,
TestEmbeddedSolrServerConstructors, ActionThrottleTest,
AsyncCallRequestStatusResponseTest, CollectionStateFormat2Test,
DeleteInactiveReplicaTest, ForceLeaderTest,
LeaderInitiatedRecoveryOnShardRestartTest]
[junit4] Completed [431/551] on J1 in 418.90s, 1 test, 1 failure <<<
FAILURES!
[...truncated 413 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:799:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:736:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/solr/common-build.xml:526:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1452:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-5.4/lucene/common-build.xml:1006:
There were test failures: 551 suites (7 ignored), 2177 tests, 1 failure, 32
ignored (18 assumptions) [seed: 978B2AF96872E167]
Total time: 197 minutes 57 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
