Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/872/
3 tests failed.
FAILED:
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterLeaderChange
Error Message:
Timeout while trying to assert number of documents on collection:
target_collection
Stack Trace:
java.lang.AssertionError: Timeout while trying to assert number of documents on
collection: target_collection
at
__randomizedtesting.SeedInfo.seed([B76FFC4460F69B3F:659FB0A73E593D0D]:0)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:265)
at
org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testReplicationAfterLeaderChange(CdcrReplicationDistributedZkTest.java:292)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
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:965)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
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)
Caused by: java.lang.AssertionError: expected:<10> but was:<4>
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.BaseCdcrDistributedZkTest.assertNumDocs(BaseCdcrDistributedZkTest.java:256)
... 42 more
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=27801, name=collection1,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=27801, name=collection1, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([B76FFC4460F69B3F:3F3BC39ECE0AF6C7]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:43225: Could not find collection :
awholynewstresscollection_collection1_2
at __randomizedtesting.SeedInfo.seed([B76FFC4460F69B3F]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:575)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:871)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:807)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:888)
FAILED: org.apache.solr.cloud.RollingRestartTest.test
Error Message:
Unable to restart (#6): CloudJettyRunner
[url=http://127.0.0.1:58263/_/s/collection1]
Stack Trace:
java.lang.AssertionError: Unable to restart (#6): CloudJettyRunner
[url=http://127.0.0.1:58263/_/s/collection1]
at
__randomizedtesting.SeedInfo.seed([B76FFC4460F69B3F:3F3BC39ECE0AF6C7]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.RollingRestartTest.restartWithRolesTest(RollingRestartTest.java:104)
at
org.apache.solr.cloud.RollingRestartTest.test(RollingRestartTest.java:53)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:497)
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:965)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
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 10433 lines...]
[junit4] Suite: org.apache.solr.cloud.CdcrReplicationDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/init-core-data-001
[junit4] 2> 1061290 INFO
(SUITE-CdcrReplicationDistributedZkTest-seed#[B76FFC4460F69B3F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 1061290 INFO
(SUITE-CdcrReplicationDistributedZkTest-seed#[B76FFC4460F69B3F]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /x_/
[junit4] 2> 1061292 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1061292 INFO (Thread-2639) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1061292 INFO (Thread-2639) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1061392 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkTestServer start zk server on port:43900
[junit4] 2> 1061393 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1061395 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061397 INFO (zkCallback-768-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@f49107b name:ZooKeeperConnection
Watcher:127.0.0.1:43900 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 1061397 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061397 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1061397 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 1061403 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1061410 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061411 INFO (zkCallback-769-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@cdfea3e name:ZooKeeperConnection
Watcher:127.0.0.1:43900/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 1061411 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061411 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1061411 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 1061413 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 1061414 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 1061415 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 1061417 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-cdcr.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1061417 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 1061419 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 1061419 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 1061421 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1061421 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1061422 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1061423 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 1061424 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1061424 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 1061426 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1061426 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 1061427 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1061427 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 1061429 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1061429 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 1061430 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1061430 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1061432 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1061432 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 1061434 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1061434 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 1061435 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testOps
[junit4] 2> 1061784 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1
[junit4] 2> 1061786 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 1061795 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7221ed5b{/x_,null,AVAILABLE}
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@2f3f3a64{HTTP/1.1,[http/1.1]}{127.0.0.1:36461}
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.Server Started @1065655ms
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard1, hostContext=/x_,
hostPort=36461,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores}
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001'
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1061802 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1061803 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1061804 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061811 INFO (zkCallback-770-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6860b671
name:ZooKeeperConnection Watcher:127.0.0.1:43900/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1061811 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061811 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1061812 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1061812 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/solr.xml
[junit4] 2> 1061818 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores
[junit4] 2> 1061818 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer New CoreContainer 151017493
[junit4] 2> 1061818 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001]
[junit4] 2> 1061818 WARN
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/lib
[junit4] 2> 1061819 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
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> 1061820 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1061820 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1061820 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1061820 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43900/solr
[junit4] 2> 1061820 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1061821 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1061831 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1061843 INFO (zkCallback-772-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@56a756b0
name:ZooKeeperConnection Watcher:127.0.0.1:43900 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1061847 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1061847 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1061850 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1061850 INFO
(zkCallback-773-thread-1-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6bcb3fe8
name:ZooKeeperConnection Watcher:127.0.0.1:43900/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1061850 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1061851 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 1061853 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 1061855 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 1061856 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 1061858 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 1061863 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 1061864 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 1061865 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 1061866 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 1061867 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36461_x_
[junit4] 2> 1061867 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:36461_x_
[junit4] 2> 1061868 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 1061869 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 1061870 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1061870 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/94981354981752836-127.0.0.1:36461_x_-n_0000000000
[junit4] 2> 1061871 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:36461_x_
[junit4] 2> 1061871 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 1061872 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer Overseer
(id=94981354981752836-127.0.0.1:36461_x_-n_0000000000) starting
[junit4] 2> 1061873 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 1061881 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 1061883 INFO
(OverseerCollectionConfigSetProcessor-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 1061883 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1061883 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 1061897 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1061897 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1061898 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores
[junit4] 2> 1061899 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=tmp_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1061899 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1
[junit4] 2> 1061899 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 1061903 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1061903 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1061904 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
[junit4] 2> 1061904 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:36461_x_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1061905 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36461/x_";,
[junit4] 2> "node_name":"127.0.0.1:36461_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 1061905 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 1061906 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36461/x_";,
[junit4] 2> "node_name":"127.0.0.1:36461_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1061906 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
tmp_collection
[junit4] 2> 1061906 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 1061907 INFO
(zkCallback-773-thread-1-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] 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> 1062905 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 1062906 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:tmp_collection
[junit4] 2> 1062906 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Creating collection in ZooKeeper:tmp_collection
[junit4] 2> 1062906 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Looking for collection configName
[junit4] 2> 1062907 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Only one config set found in zk - using it:conf1
[junit4] 2> 1062907 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.c.SolrZkClient
makePath: /collections/tmp_collection
[junit4] 2> 1062908 INFO
(zkCallback-773-thread-1-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] o.a.s.c.c.ZkStateReader A collections change: WatchedEvent
state:SyncConnected type:NodeChildrenChanged path:/collections, has occurred -
updating...
[junit4] 2> 1062908 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
Load collection config from:/collections/tmp_collection
[junit4] 2> 1062909 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
path=/collections/tmp_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1062909 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1'
[junit4] 2> 1062909 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1062909 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1062910 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 1062915 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 1062919 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1062926 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1062931 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1063041 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 1063043 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 1063044 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1063047 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1063073 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_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-trunk/solr/build/solr-core/test/J2
[junit4] 2> 1063073 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 1063073 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1063073 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1],
dataDir=[null]
[junit4] 2> 1063073 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 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@427ed5b8
[junit4] 2> 1063074 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data
[junit4] 2> 1063074 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 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-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data/index/
[junit4] 2> 1063074 WARN
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 1063075 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data/index
[junit4] 2> 1063075 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=34, maxMergeAtOnceExplicit=14, maxMergedSegmentMB=49.3115234375,
floorSegmentMB=0.8984375, forceMergeDeletesPctAllowed=5.371060523746926,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1063076 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@447665e1
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3f3f9e0a),segFN=segments_1,generation=1}
[junit4] 2> 1063076 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1063076 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:36461_x_
c:tmp_collection s:shard2 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-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data/
[junit4] 2> 1063076 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:36461_x_
c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 1063080 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"cdcr-processor-chain"
[junit4] 2> 1063080 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating
implicit default
[junit4] 2> 1063082 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1063083 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1063084 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1063085 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 1063087 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/cdcr,/update,/admin/file
[junit4] 2> 1063087 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 1063088 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 1063088 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1063089 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1063089 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1063089 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@602f75dd
[junit4] 2> 1063089 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@447665e1
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3f3f9e0a),segFN=segments_1,generation=1}
[junit4] 2> 1063089 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 1063090 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening Searcher@6cfe8b89[collection1] main
[junit4] 2> 1063090 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:/collections/tmp_collection
[junit4] 2> 1063090 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/tmp_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 1063090 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the
RestManager with znodeBase: /configs/conf1
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 1063091 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1063092 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection/cdcr/state
[junit4] 2> 1063094 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.CdcrBufferStateManager Created znode
/collections/tmp_collection/cdcr/state/buffer
[junit4] 2> 1063095 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.h.CdcrProcessStateManager Created znode
/collections/tmp_collection/cdcr/state/process
[junit4] 2> 1063096 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets
[junit4] 2> 1063096 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version
buckets from index
[junit4] 2> 1063096 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 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> 1063096 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1519701681597579264
[junit4] 2> 1063098 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version
1519701681597579264
[junit4] 2> 1063098 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 1063098 INFO
(coreLoadExecutor-1976-thread-1-processing-n:127.0.0.1:36461_x_)
[n:127.0.0.1:36461_x_ c:tmp_collection s:shard2 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 1063099 INFO
(searcherExecutor-1977-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered
new searcher Searcher@6cfe8b89[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1063099 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica -
core:collection1 address:http://127.0.0.1:36461/x_ collection:tmp_collection
shard:shard2
[junit4] 2> 1063104 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/tmp_collection/leader_elect/shard2/election
[junit4] 2> 1063108 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership
election with path:
/collections/tmp_collection/leader_elect/shard2/election/94981354981752836-core_node1-n_0000000000
[junit4] 2> 1063109 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running
the leader process for shard shard2
[junit4] 2> 1063110 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 1063110 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may
be the new leader - try and sync
[junit4] 2> 1063110 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36461/x_/collection1/
[junit4] 2> 1063110 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now
sync replicas to me
[junit4] 2> 1063110 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"tmp_collection"} current state version: 1
[junit4] 2> 1063110 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:36461/x_/collection1/ has no replicas
[junit4] 2> 1063113 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/tmp_collection/leaders/shard2
[junit4] 2> 1063115 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase
Creating leader registration node
[junit4] 2> 1063115 INFO
(zkCallback-773-thread-1-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] o.a.s.h.CdcrLeaderStateManager Received new leader state @
tmp_collection:shard2
[junit4] 2> 1063117 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am
the new leader: http://127.0.0.1:36461/x_/collection1/ shard2
[junit4] 2> 1063118 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "base_url":"http://127.0.0.1:36461/x_";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 1063220 INFO
(zkCallback-773-thread-1-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] 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> 1063269 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController We are
http://127.0.0.1:36461/x_/collection1/ and leader is
http://127.0.0.1:36461/x_/collection1/
[junit4] 2> 1063269 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed
for core=collection1 baseURL=http://127.0.0.1:36461/x_
[junit4] 2> 1063269 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 1063269 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController publishing
state=active
[junit4] 2> 1063269 INFO
(coreZkRegister-1970-thread-1-processing-n:127.0.0.1:36461_x_ x:collection1
s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:36461_x_ c:tmp_collection
s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found
on descriptor - reading it from system property
[junit4] 2> 1063271 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36461/x_";,
[junit4] 2> "node_name":"127.0.0.1:36461_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 1063271 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36461/x_";,
[junit4] 2> "node_name":"127.0.0.1:36461_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard2",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1063379 INFO
(zkCallback-773-thread-2-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] 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> 1063733 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1
[junit4] 2> 1063735 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 1063737 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@34f7c21e{/x_,null,AVAILABLE}
[junit4] 2> 1063737 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@2828313b{HTTP/1.1,[http/1.1]}{127.0.0.1:53688}
[junit4] 2> 1063737 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.e.j.s.Server Started @1067590ms
[junit4] 2> 1063737 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard2, hostContext=/x_,
hostPort=53688,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores}
[junit4] 2> 1063738 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 1063738 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002'
[junit4] 2> 1063738 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1063738 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1063738 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1063743 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1063745 INFO (zkCallback-774-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@392bb810
name:ZooKeeperConnection Watcher:127.0.0.1:43900/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1063745 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1063745 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1063746 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1063746 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/solr.xml
[junit4] 2> 1063752 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores
[junit4] 2> 1063752 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer New CoreContainer 1490061214
[junit4] 2> 1063752 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002]
[junit4] 2> 1063752 WARN
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/lib
[junit4] 2> 1063752 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
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> 1063753 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1063754 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 1063754 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 1063754 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43900/solr
[junit4] 2> 1063754 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 1063754 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 1063755 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 1063756 INFO (zkCallback-776-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@754599fe
name:ZooKeeperConnection Watcher:127.0.0.1:43900 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1063756 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 1063757 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 1063758 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 1063759 INFO
(zkCallback-777-thread-1-processing-n:127.0.0.1:53688_x_) [n:127.0.0.1:53688_x_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3e672e0a
name:ZooKeeperConnection Watcher:127.0.0.1:43900/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 1063759 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 1063764 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 1064775 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53688_x_
[junit4] 2> 1064775 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:53688_x_
[junit4] 2> 1064776 INFO
(zkCallback-777-thread-1-processing-n:127.0.0.1:53688_x_) [n:127.0.0.1:53688_x_
] 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> 1064776 INFO
(zkCallback-773-thread-2-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] 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> 1064777 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1064777 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/94981354981752839-127.0.0.1:53688_x_-n_0000000001
[junit4] 2> 1064778 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/94981354981752836-127.0.0.1:36461_x_-n_0000000000 to
know if I could be the leader
[junit4] 2> 1064788 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 1064788 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 1064789 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores
[junit4] 2> 1064790 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=tmp_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 1064790 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1
[junit4] 2> 1064790 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 1064791 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 1064791 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 1064791 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2
[junit4] 2> 1064791 INFO
(TEST-CdcrReplicationDistributedZkTest.testOps-seed#[B76FFC4460F69B3F])
[n:127.0.0.1:53688_x_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 1064792 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Registering watch for collection tmp_collection
[junit4] 2> 1064792 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
addZkWatch tmp_collection
[junit4] 2> 1064792 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53688/x_";,
[junit4] 2> "node_name":"127.0.0.1:53688_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 1064793 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
Deleting data for tmp_collection
[junit4] 2> 1064793 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Update state numShards=2
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:53688/x_";,
[junit4] 2> "node_name":"127.0.0.1:53688_x_",
[junit4] 2> "numShards":"2",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 1064793 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Collection already exists
with numShards=2
[junit4] 2> 1064793 INFO
(OverseerStateUpdate-94981354981752836-127.0.0.1:36461_x_-n_0000000000)
[n:127.0.0.1:36461_x_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 1064795 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 1064895 INFO
(zkCallback-773-thread-2-processing-n:127.0.0.1:36461_x_) [n:127.0.0.1:36461_x_
] 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> 1064895 INFO
(zkCallback-777-thread-1-processing-n:127.0.0.1:53688_x_) [n:127.0.0.1:53688_x_
] 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> 1065795 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 1065795 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:tmp_collection
[junit4] 2> 1065796 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 1065796 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
Load collection config from:/collections/tmp_collection
[junit4] 2> 1065797 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader
path=/collections/tmp_collection configName=conf1 specified config exists in
ZooKeeper
[junit4] 2> 1065797 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1'
[junit4] 2> 1065797 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 1065797 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 1065798 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 1065803 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 1065806 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 1065823 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 1065828 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 1065908 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 1065909 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 1065910 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1065912 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 1065927 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_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-trunk/solr/build/solr-core/test/J2
[junit4] 2> 1065927 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
tmp_collection
[junit4] 2> 1065928 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 1065928 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1],
dataDir=[null]
[junit4] 2> 1065928 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@427ed5b8
[junit4] 2> 1065928 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1/data
[junit4] 2> 1065928 INFO
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1/data/index/
[junit4] 2> 1065928 WARN
(coreLoadExecutor-1988-thread-1-processing-n:127.0.0.1:53688_x_)
[n:127.0.0.1:53688_x_ c:tmp_collection s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.cloud.CdcrReplicationDistributedZkTest_B76FFC4460F69B3F-001/jetty-002/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 1065929 INFO (co
[...truncated too long message...]
000019
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691933-core_node11-n_0000000038
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691897-core_node15-n_0000000031
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691837-127.0.0.1:40249__%2Fs-n_0000000053
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080691864-core_node14-n_0000000022
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080691768-core_node14-n_0000000008
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691828-core_node3-n_0000000018
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080692056-core_node14-n_0000000050
[junit4] 2> 2
/solr/overseer_elect/election/94981491080692008-127.0.0.1:38552__%2Fs-n_0000000130
[junit4] 2> 2
/solr/overseer_elect/election/94981491080692035-127.0.0.1:58263__%2Fs-n_0000000144
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691738-127.0.0.1:56511__%2Fs-n_0000000081
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691939-127.0.0.1:58263__%2Fs-n_0000000102
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691750-core_node11-n_0000000005
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080692029-core_node11-n_0000000056
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080691987-core_node10-n_0000000041
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691924-core_node3-n_0000000036
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080692008-core_node14-n_0000000043
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691981-127.0.0.1:40249__%2Fs-n_0000000121
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691993-core_node15-n_0000000049
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard2/election/94981491080691981-core_node11-n_0000000047
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/94981491080691912-core_node14-n_0000000029
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691912-127.0.0.1:38552__%2Fs-n_0000000088
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691762-127.0.0.1:46468__%2Fs-n_0000000015
[junit4] 2> 2
/solr/overseer_elect/election/94981491080691816-127.0.0.1:38552__%2Fs-n_0000000046
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 123 /solr/collections
[junit4] 2> 56 /solr/overseer/collection-queue-work
[junit4] 2> 54 /solr/overseer/queue
[junit4] 2> 18 /solr/live_nodes
[junit4] 2> 11 /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=RollingRestartTest
-Dtests.method=test -Dtests.seed=B76FFC4460F69B3F -Dtests.multiplier=2
-Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=ko_KR -Dtests.timezone=Pacific/Enderbury -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 842s J0 | RollingRestartTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: Unable to restart
(#6): CloudJettyRunner [url=http://127.0.0.1:58263/_/s/collection1]
[junit4] > at
__randomizedtesting.SeedInfo.seed([B76FFC4460F69B3F:3F3BC39ECE0AF6C7]:0)
[junit4] > at
org.apache.solr.cloud.RollingRestartTest.restartWithRolesTest(RollingRestartTest.java:104)
[junit4] > at
org.apache.solr.cloud.RollingRestartTest.test(RollingRestartTest.java:53)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:965)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:940)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 3980040 INFO
(SUITE-RollingRestartTest-seed#[B76FFC4460F69B3F]-worker)
[n:127.0.0.1:34304__%2Fs c:collection1 s:shard1 r:core_node16 x:collection1]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.RollingRestartTest_B76FFC4460F69B3F-001
[junit4] 2> Dec 05, 2015 8:16:19 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {},
docValues:{}, sim=ClassicSimilarity, locale=ko_KR, timezone=Pacific/Enderbury
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_66 (64-bit)/cpus=4,threads=1,free=242602144,total=521142272
[junit4] 2> NOTE: All tests run in this JVM: [TestReplicationHandler,
DistributedQueryElevationComponentTest, TestComponentsName, TestLazyCores,
SSLMigrationTest, TestDocBasedVersionConstraints, StressHdfsTest,
TestFieldTypeCollectionResource, RuleEngineTest, UUIDFieldTest,
ParsingFieldUpdateProcessorsTest, DocumentAnalysisRequestHandlerTest,
TestConfigSetProperties, TestExactSharedStatsCache, SolrCoreTest,
TestSolrQueryParserDefaultOperatorResource, TestCollectionAPI,
URLClassifyProcessorTest, TestNoOpRegenerator, TestFileDictionaryLookup,
TestMergePolicyConfig, SyncSliceTest, CdcrVersionReplicationTest,
TestAuthenticationFramework, DataDrivenBlockJoinTest, MigrateRouteKeyTest,
DisMaxRequestHandlerTest, ConjunctionSolrSpellCheckerTest,
RAMDirectoryFactoryTest, SOLR749Test, TestLRUCache, BufferStoreTest,
MergeStrategyTest, TestFoldingMultitermQuery, FileBasedSpellCheckerTest,
TestTolerantSearch, JSONWriterTest, TestFastOutputStream, DocValuesMissingTest,
OverriddenZkACLAndCredentialsProvidersTest, TestDistributedSearch,
TestSolrCLIRunExample, TestFaceting, TestFieldResource, ResponseHeaderTest,
SolrRequestParserTest, TestDistributedStatsComponentCardinality,
CacheHeaderTest, TestAtomicUpdateErrorCases, DefaultValueUpdateProcessorTest,
TestUniqueKeyFieldResource, BasicAuthIntegrationTest, SpatialHeatmapFacetsTest,
ConnectionManagerTest, TestRandomFaceting, TestAnalyzedSuggestions,
DeleteReplicaTest, DistributedVersionInfoTest, TestFieldTypeResource,
TestFieldCollectionResource, CloneFieldUpdateProcessorFactoryTest,
ResourceLoaderTest, TestJoin, SignatureUpdateProcessorFactoryTest,
TestJsonRequest, TestRandomDVFaceting, TestRandomRequestDistribution,
HLLSerializationTest, PolyFieldTest,
TestOverriddenPrefixQueryForCustomFieldType, TestFunctionQuery,
TestPerFieldSimilarityClassic, TriLevelCompositeIdRoutingTest, EchoParamsTest,
ReturnFieldsTest, DeleteShardTest, PreAnalyzedFieldTest, RequiredFieldsTest,
TestLMDirichletSimilarityFactory, TestSmileRequest, TestArbitraryIndexDir,
TestLRUStatsCache, IndexSchemaTest, TestPseudoReturnFields, TestBadConfig,
StandardRequestHandlerTest, TestSolr4Spatial, AlternateDirectoryTest,
TestCryptoKeys, DistributedQueueTest, TestCloudPivotFacet,
TestMinMaxOnMultiValuedField, BasicDistributedZkTest,
LeaderElectionIntegrationTest, BasicZkTest, TestZkChroot,
TestDistributedGrouping, TestHashPartitioner,
TermVectorComponentDistributedTest, DistributedTermsComponentTest,
SpellCheckComponentTest, TestGroupingSearch, SolrCmdDistributorTest,
BadIndexSchemaTest, TestFiltering, DistanceFunctionTest,
XsltUpdateRequestHandlerTest, TestQueryUtils, TestOmitPositions,
DocumentBuilderTest, TermVectorComponentTest, TestSolrQueryParser,
RegexBoostProcessorTest, JsonLoaderTest, CSVRequestHandlerTest,
UpdateParamsTest, TestQuerySenderNoQuery, ResponseLogComponentTest,
BadComponentTest, TestStressRecovery, SolrTestCaseJ4Test,
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort,
TestEmbeddedSolrServerConstructors, ActionThrottleTest, AliasIntegrationTest,
CloudExitableDirectoryReaderTest, CollectionsAPIAsyncDistributedZkTest,
DeleteInactiveReplicaTest, DistribDocExpirationUpdateProcessorTest,
MultiThreadedOCPTest, OverseerStatusTest, RecoveryAfterSoftCommitTest,
RollingRestartTest]
[junit4] Completed [458/564] on J0 in 843.04s, 1 test, 1 failure <<<
FAILURES!
[...truncated 338 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:789:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:726:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:516:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1432:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:987:
There were test failures: 564 suites (8 ignored), 2237 tests, 1 error, 2
failures, 33 ignored (18 assumptions) [seed: B76FFC4460F69B3F]
Total time: 233 minutes 46 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]
