Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/837/
3 tests failed.
FAILED: org.apache.solr.cloud.CdcrReplicationHandlerTest.doTest
Error Message:
Captured an uncaught exception in thread: Thread[id=3516,
name=RecoveryThread-source_collection_shard1_replica2, state=RUNNABLE,
group=TGRP-CdcrReplicationHandlerTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=3516,
name=RecoveryThread-source_collection_shard1_replica2, state=RUNNABLE,
group=TGRP-CdcrReplicationHandlerTest]
Caused by: org.apache.solr.common.cloud.ZooKeeperException:
at __randomizedtesting.SeedInfo.seed([7B0BD13C5F474F3C]:0)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:232)
Caused by: org.apache.solr.common.SolrException: java.io.FileNotFoundException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/source_collection_shard1_replica2/data/tlog/tlog.0000000000000000006.1516476067262496768
(No such file or directory)
at
org.apache.solr.update.CdcrTransactionLog.reopenOutputStream(CdcrTransactionLog.java:244)
at
org.apache.solr.update.CdcrTransactionLog.incref(CdcrTransactionLog.java:173)
at
org.apache.solr.update.UpdateLog.getRecentUpdates(UpdateLog.java:1079)
at
org.apache.solr.update.UpdateLog.seedBucketsWithHighestVersion(UpdateLog.java:1579)
at
org.apache.solr.update.UpdateLog.seedBucketsWithHighestVersion(UpdateLog.java:1610)
at org.apache.solr.core.SolrCore.seedVersionBuckets(SolrCore.java:877)
at
org.apache.solr.cloud.RecoveryStrategy.doRecovery(RecoveryStrategy.java:534)
at org.apache.solr.cloud.RecoveryStrategy.run(RecoveryStrategy.java:225)
Caused by: java.io.FileNotFoundException:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/source_collection_shard1_replica2/data/tlog/tlog.0000000000000000006.1516476067262496768
(No such file or directory)
at java.io.RandomAccessFile.open0(Native Method)
at java.io.RandomAccessFile.open(RandomAccessFile.java:316)
at java.io.RandomAccessFile.<init>(RandomAccessFile.java:243)
at
org.apache.solr.update.CdcrTransactionLog.reopenOutputStream(CdcrTransactionLog.java:236)
... 7 more
FAILED:
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload
Error Message:
expected:<[{indexVersion=1446226431125,generation=2,filelist=[_0.fdt, _0.fdx,
_0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _1.fdt, _1.fdx, _1.fnm, _1.nvd, _1.nvm, _1.si,
_1_BlockTreeOrds_0.doc, _1_BlockTreeOrds_0.tio, _1_BlockTreeOrds_0.tipo,
_2.fdt, _2.fdx, _2.fnm, _2.nvd, _2.nvm, _2.si, _2_BlockTreeOrds_0.doc,
_2_BlockTreeOrds_0.tio, _2_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm,
_3.nvd, _3.nvm, _3.si, _3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio,
_3_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si,
_4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, segments_2]}]> but
was:<[{indexVersion=1446226431125,generation=2,filelist=[_0.fdt, _0.fdx,
_0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _1.fdt, _1.fdx, _1.fnm, _1.nvd, _1.nvm, _1.si,
_1_BlockTreeOrds_0.doc, _1_BlockTreeOrds_0.tio, _1_BlockTreeOrds_0.tipo,
_2.fdt, _2.fdx, _2.fnm, _2.nvd, _2.nvm, _2.si, _2_BlockTreeOrds_0.doc,
_2_BlockTreeOrds_0.tio, _2_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm,
_3.nvd, _3.nvm, _3.si, _3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio,
_3_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si,
_4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, segments_2]},
{indexVersion=1446226431125,generation=3,filelist=[_0.fdt, _0.fdx, _0.fnm,
_0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm, _3.nvd, _3.nvm, _3.si,
_3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio, _3_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, _6.cfe, _6.cfs, _6.si,
segments_3]}]>
Stack Trace:
java.lang.AssertionError:
expected:<[{indexVersion=1446226431125,generation=2,filelist=[_0.fdt, _0.fdx,
_0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _1.fdt, _1.fdx, _1.fnm, _1.nvd, _1.nvm, _1.si,
_1_BlockTreeOrds_0.doc, _1_BlockTreeOrds_0.tio, _1_BlockTreeOrds_0.tipo,
_2.fdt, _2.fdx, _2.fnm, _2.nvd, _2.nvm, _2.si, _2_BlockTreeOrds_0.doc,
_2_BlockTreeOrds_0.tio, _2_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm,
_3.nvd, _3.nvm, _3.si, _3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio,
_3_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si,
_4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, segments_2]}]> but
was:<[{indexVersion=1446226431125,generation=2,filelist=[_0.fdt, _0.fdx,
_0.fnm, _0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _1.fdt, _1.fdx, _1.fnm, _1.nvd, _1.nvm, _1.si,
_1_BlockTreeOrds_0.doc, _1_BlockTreeOrds_0.tio, _1_BlockTreeOrds_0.tipo,
_2.fdt, _2.fdx, _2.fnm, _2.nvd, _2.nvm, _2.si, _2_BlockTreeOrds_0.doc,
_2_BlockTreeOrds_0.tio, _2_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm,
_3.nvd, _3.nvm, _3.si, _3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio,
_3_BlockTreeOrds_0.tipo, _4.fdt, _4.fdx, _4.fnm, _4.nvd, _4.nvm, _4.si,
_4_BlockTreeOrds_0.doc, _4_BlockTreeOrds_0.tio, _4_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, segments_2]},
{indexVersion=1446226431125,generation=3,filelist=[_0.fdt, _0.fdx, _0.fnm,
_0.nvd, _0.nvm, _0.si, _0_BlockTreeOrds_0.doc, _0_BlockTreeOrds_0.tio,
_0_BlockTreeOrds_0.tipo, _3.fdt, _3.fdx, _3.fnm, _3.nvd, _3.nvm, _3.si,
_3_BlockTreeOrds_0.doc, _3_BlockTreeOrds_0.tio, _3_BlockTreeOrds_0.tipo,
_5.fdt, _5.fdx, _5.fnm, _5.nvd, _5.nvm, _5.si, _5_BlockTreeOrds_0.doc,
_5_BlockTreeOrds_0.tio, _5_BlockTreeOrds_0.tipo, _6.cfe, _6.cfs, _6.si,
segments_3]}]>
at
__randomizedtesting.SeedInfo.seed([7B0BD13C5F474F3C:5EDCCA0C2F0F413F]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:147)
at
org.apache.solr.handler.TestReplicationHandler.doTestReplicateAfterCoreReload(TestReplicationHandler.java:1138)
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:1660)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:866)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:902)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:916)
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:875)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:777)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:811)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:822)
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)
FAILED:
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR
Error Message:
Captured an uncaught exception in thread: Thread[id=9715,
name=coreZkRegister-1572-thread-1, state=RUNNABLE,
group=TGRP-LeaderInitiatedRecoveryOnShardRestartTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=9715, name=coreZkRegister-1572-thread-1,
state=RUNNABLE, group=TGRP-LeaderInitiatedRecoveryOnShardRestartTest]
Caused by: java.lang.AssertionError
at __randomizedtesting.SeedInfo.seed([7B0BD13C5F474F3C]:0)
at
org.apache.solr.cloud.ZkController.updateLeaderInitiatedRecoveryState(ZkController.java:2126)
at
org.apache.solr.cloud.ShardLeaderElectionContext.runLeaderProcess(ElectionContext.java:433)
at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:197)
at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:157)
at
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:346)
at
org.apache.solr.cloud.ZkController.joinElection(ZkController.java:1113)
at org.apache.solr.cloud.ZkController.register(ZkController.java:926)
at org.apache.solr.cloud.ZkController.register(ZkController.java:881)
at org.apache.solr.core.ZkContainer$2.run(ZkContainer.java:183)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor$1.run(ExecutorUtil.java:231)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 10147 lines...]
[junit4] Suite: org.apache.solr.cloud.CdcrReplicationHandlerTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/init-core-data-001
[junit4] 2> 307425 INFO
(SUITE-CdcrReplicationHandlerTest-seed#[7B0BD13C5F474F3C]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false)
[junit4] 2> 307425 INFO
(SUITE-CdcrReplicationHandlerTest-seed#[7B0BD13C5F474F3C]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/ng_tlq/yp
[junit4] 2> 307428 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 307428 INFO (Thread-2352) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 307429 INFO (Thread-2352) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 307529 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkTestServer start zk server on port:58274
[junit4] 2> 307529 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 307530 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 307535 INFO (zkCallback-140-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7b4adee4
name:ZooKeeperConnection Watcher:127.0.0.1:58274 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 307535 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 307536 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 307536 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 307540 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 307540 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 307542 INFO (zkCallback-141-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1f4e0c4c
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 307542 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 307542 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 307543 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 307545 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 307547 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 307549 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 307551 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307551 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 307554 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307554 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 307556 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307556 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 307558 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307558 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 307560 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307560 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 307562 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307562 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 307564 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307564 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 307566 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307566 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 307569 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307570 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 307573 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307573 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 307576 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 307576 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 307579 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 307580 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 307585 INFO (zkCallback-142-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@54c56b81
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 307585 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 307585 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 307588 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTest
[junit4] 2> 307974 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1
[junit4] 2> 307996 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 308000 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@17b40073{/ng_tlq/yp,null,AVAILABLE}
[junit4] 2> 308083 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@3f97b5e{SSL-http/1.1}{127.0.0.1:60881}
[junit4] 2> 308083 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.Server Started @310984ms
[junit4] 2> 308083 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard1,
hostContext=/ng_tlq/yp, hostPort=60881,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores}
[junit4] 2> 308084 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 308084 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/'
[junit4] 2> 308084 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 308084 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 308102 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 308103 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 308111 INFO (zkCallback-143-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@24cb423c
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 308111 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 308111 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 308113 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 308113 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/solr.xml
[junit4] 2> 308121 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores
[junit4] 2> 308121 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer New CoreContainer 611436622
[junit4] 2> 308121 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/]
[junit4] 2> 308121 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/lib
[junit4] 2> 308121 WARN
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/lib).
[junit4] 2> 308141 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 308144 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 308147 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 308147 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 308147 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58274/solr
[junit4] 2> 308147 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 308147 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 308148 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 308153 INFO (zkCallback-145-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@75c0f229
name:ZooKeeperConnection Watcher:127.0.0.1:58274 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 308153 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 308154 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 308157 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 308161 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5061ca7f
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 308161 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 308163 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue
[junit4] 2> 308165 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 308168 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 308170 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 308173 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 308176 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 308178 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/aliases.json
[junit4] 2> 308180 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 308181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/security.json
[junit4] 2> 308183 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:60881_ng_tlq%2Fyp
[junit4] 2> 308183 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:60881_ng_tlq%2Fyp
[junit4] 2> 308186 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect
[junit4] 2> 308187 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 308189 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 308190 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.LeaderElector Joined leadership
election with path:
/overseer_elect/election/94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000
[junit4] 2> 308191 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.OverseerElectionContext I am going
to be the leader 127.0.0.1:60881_ng_tlq%2Fyp
[junit4] 2> 308191 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 308192 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer Overseer
(id=94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000) starting
[junit4] 2> 308195 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 308201 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 308201 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.ZkStateReader Updating cluster
state from ZooKeeper...
[junit4] 2> 308201 INFO
(OverseerCollectionConfigSetProcessor-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.OverseerTaskProcessor Process
current queue of overseer operations
[junit4] 2> 308202 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer Starting to work on the
main queue
[junit4] 2> 308220 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 308220 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.CoreContainer No authentication
plugin used.
[junit4] 2> 308221 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores
[junit4] 2> 308222 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1,
collection=tmp_collection,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 308222 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/
[junit4] 2> 308222 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Found 1 core
definitions
[junit4] 2> 308223 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 308223 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 308223 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 308223 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 308225 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 308225 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer processMessage:
queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:60881/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:60881_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 308226 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:60881/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:60881_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 308226 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ClusterStateMutator building a
new cName: tmp_collection
[junit4] 2> 308226 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Assigning new
node to shard shard=shard1
[junit4] 2> 308227 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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> 309225 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 309225 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:tmp_collection
[junit4] 2> 309226 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Creating collection in ZooKeeper:tmp_collection
[junit4] 2> 309226 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Looking for collection configName
[junit4] 2> 309227 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Only one config set found in zk - using it:conf1
[junit4] 2> 309228 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection
[junit4] 2> 309230 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.c.ZkStateReader A collections
change: WatchedEvent state:SyncConnected type:NodeChildrenChanged
path:/collections, has occurred - updating...
[junit4] 2> 309230 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:/collections/tmp_collection
[junit4] 2> 309231 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/tmp_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 309231 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp 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/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/'
[junit4] 2> 309231 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 309231 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 309249 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 309255 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 309258 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 309265 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1] o.a.s.c.Config
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 309267 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 309271 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 309357 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 309358 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 309359 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 309362 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 309386 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp 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/J0
[junit4] 2> 309386 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection tmp_collection
[junit4] 2> 309386 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore solr.StandardDirectoryFactory
[junit4] 2> 309393 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/],
dataDir=[null]
[junit4] 2> 309393 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@74b9fdd0
[junit4] 2> 309394 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data
[junit4] 2> 309394 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/index/
[junit4] 2> 309394 WARN
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 309395 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/index
[junit4] 2> 309395 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=33, maxMergeAtOnceExplicit=26, maxMergedSegmentMB=31.65625,
floorSegmentMB=1.341796875, forceMergeDeletesPctAllowed=11.370204429928904,
segmentsPerTier=26.0, maxCFSSegmentSizeMB=0.244140625, noCFSRatio=1.0
[junit4] 2> 309401 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2>
commit{dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/index,segFN=segments_1,generation=1}
[junit4] 2> 309401 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 309402 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup
for core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/
[junit4] 2> 309406 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "cdcr-processor-chain"
[junit4] 2> 309422 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 309428 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 309429 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 309430 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 309431 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 309443 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 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> 309443 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 309453 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.CdcrUpdateLog
[junit4] 2> 309453 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 309454 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 309454 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 309456 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=710886250,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 309457 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2>
commit{dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-001/cores/collection1/data/index,segFN=segments_1,generation=1}
[junit4] 2> 309457 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 309457 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@35686949[collection1]
main
[junit4] 2> 309457 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Load collection config
from:/collections/tmp_collection
[junit4] 2> 309458 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader path=/collections/tmp_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 309458 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 309458 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 309458 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 309459 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 309459 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 309459 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 309459 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 309459 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 309464 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/tmp_collection/cdcr/state
[junit4] 2> 309468 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.CdcrBufferStateManager Created znode
/collections/tmp_collection/cdcr/state/buffer
[junit4] 2> 309474 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.CdcrProcessStateManager Created znode
/collections/tmp_collection/cdcr/state/process
[junit4] 2> 309494 INFO
(searcherExecutor-593-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@35686949[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 309494 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed
version buckets
[junit4] 2> 309494 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for
65536 version buckets from index
[junit4] 2> 309494 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed
version bucket highest value from index
[junit4] 2> 309494 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1516476002707963904
[junit4] 2> 309496 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with
highest version 1516476002707963904
[junit4] 2> 309496 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 309497 INFO
(coreLoadExecutor-592-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 309497 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController Register replica - core:collection1
address:https://127.0.0.1:60881/ng_tlq/yp collection:tmp_collection shard:shard1
[junit4] 2> 309498 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/tmp_collection/leader_elect/shard1/election
[junit4] 2> 309505 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.LeaderElector Joined leadership election with path:
/collections/tmp_collection/leader_elect/shard1/election/94779750034046981-core_node1-n_0000000000
[junit4] 2> 309505 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process
for shard shard1
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:60881/ng_tlq/yp/collection1/
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 309507 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer processMessage:
queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"tmp_collection"} current state version: 1
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy
https://127.0.0.1:60881/ng_tlq/yp/collection1/ has no replicas
[junit4] 2> 309507 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:60881/ng_tlq/yp/collection1/ shard1
[junit4] 2> 309508 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/tmp_collection/leaders/shard1
[junit4] 2> 309513 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader
registration node
[junit4] 2> 309514 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.h.CdcrProcessStateManager Received
new leader state @ tmp_collection:shard1
[junit4] 2> 309517 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer processMessage:
queueSize: 1, message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "base_url":"https://127.0.0.1:60881/ng_tlq/yp";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 309621 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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> 309669 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController We are
https://127.0.0.1:60881/ng_tlq/yp/collection1/ and leader is
https://127.0.0.1:60881/ng_tlq/yp/collection1/
[junit4] 2> 309669 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1
baseURL=https://127.0.0.1:60881/ng_tlq/yp
[junit4] 2> 309669 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 309669 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController publishing state=active
[junit4] 2> 309669 INFO
(coreZkRegister-586-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp
x:collection1 s:shard1 c:tmp_collection r:core_node1)
[n:127.0.0.1:60881_ng_tlq%2Fyp c:tmp_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading
it from system property
[junit4] 2> 309672 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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":"https://127.0.0.1:60881/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:60881_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 309674 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:60881/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:60881_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 309777 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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> 310118 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores/collection1
[junit4] 2> 310120 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.Server jetty-9.2.13.v20150730
[junit4] 2> 310122 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@45560516{/ng_tlq/yp,null,AVAILABLE}
[junit4] 2> 310132 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@5275d3dc{SSL-http/1.1}{127.0.0.1:45874}
[junit4] 2> 310132 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.Server Started @313033ms
[junit4] 2> 310132 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard2,
hostContext=/ng_tlq/yp, hostPort=45874,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores}
[junit4] 2> 310132 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 310133 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/'
[junit4] 2> 310133 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 310133 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 310151 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 310152 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 310154 INFO (zkCallback-147-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@214bbc35
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 310154 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 310155 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 310160 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 310160 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/solr.xml
[junit4] 2> 310166 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores
[junit4] 2> 310166 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer New CoreContainer 412693348
[junit4] 2> 310166 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/]
[junit4] 2> 310166 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/lib
[junit4] 2> 310167 WARN
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/lib).
[junit4] 2> 310176 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
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> 310179 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58274/solr
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 310181 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 310184 INFO (zkCallback-149-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@70f38996
name:ZooKeeperConnection Watcher:127.0.0.1:58274 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 310185 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 310186 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 310190 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 310196 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@76fa1c4f
name:ZooKeeperConnection Watcher:127.0.0.1:58274/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 310196 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 310202 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.c.ZkStateReader Updating cluster
state from ZooKeeper...
[junit4] 2> 311209 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.ZkController Register node as live
in ZooKeeper:/live_nodes/127.0.0.1:45874_ng_tlq%2Fyp
[junit4] 2> 311209 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:45874_ng_tlq%2Fyp
[junit4] 2> 311210 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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> 311210 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp ] 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> 311212 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 311212 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.LeaderElector Joined leadership
election with path:
/overseer_elect/election/94779750034046984-127.0.0.1:45874_ng_tlq%2Fyp-n_0000000001
[junit4] 2> 311213 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000
to know if I could be the leader
[junit4] 2> 311226 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 311226 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.CoreContainer No authentication
plugin used.
[junit4] 2> 311227 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores
[junit4] 2> 311227 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores/collection1,
collection=tmp_collection,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 311227 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores/collection1/
[junit4] 2> 311228 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.c.CoresLocator Found 1 core
definitions
[junit4] 2> 311229 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 311229 INFO
(TEST-CdcrReplicationHandlerTest.doTest-seed#[7B0BD13C5F474F3C])
[n:127.0.0.1:45874_ng_tlq%2Fyp ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 311229 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 311230 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 311230 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Registering watch for collection tmp_collection
[junit4] 2> 311231 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader addZkWatch tmp_collection
[junit4] 2> 311231 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.Overseer processMessage:
queueSize: 1, message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:45874/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:45874_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 311231 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader Deleting data for tmp_collection
[junit4] 2> 311232 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:45874/ng_tlq/yp";,
[junit4] 2> "node_name":"127.0.0.1:45874_ng_tlq%2Fyp",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"tmp_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 311232 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Collection
already exists with numShards=1
[junit4] 2> 311232 INFO
(OverseerStateUpdate-94779750034046981-127.0.0.1:60881_ng_tlq%2Fyp-n_0000000000)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] o.a.s.c.o.ReplicaMutator Assigning new
node to shard shard=shard1
[junit4] 2> 311234 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 311334 INFO
(zkCallback-150-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp ] 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> 311334 INFO
(zkCallback-146-thread-1-processing-n:127.0.0.1:60881_ng_tlq%2Fyp)
[n:127.0.0.1:60881_ng_tlq%2Fyp ] 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> 312234 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 312235 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:tmp_collection
[junit4] 2> 312236 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 312236 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:/collections/tmp_collection
[junit4] 2> 312236 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/tmp_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 312237 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp 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/J0/temp/solr.cloud.CdcrReplicationHandlerTest_7B0BD13C5F474F3C-001/jetty-002/cores/collection1/'
[junit4] 2> 312237 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 312237 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 312256 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 312263 INFO
(coreLoadExecutor-604-thread-1-processing-n:127.0.0.1:45874_ng_tlq%2Fyp)
[n:127.0.0.1:45874_ng_tlq%2Fyp c:tmp_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 312266 INFO (coreLoadExecutor-604-thread-1-processing-n:1
[...truncated too long message...]
474F3C-001/solr-instance-026/./collection1/data
[junit4] 2> 2530407 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-026/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-026/./collection1/data/index;done=false>>]
[junit4] 2> 2530408 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-026/./collection1/data/index
[junit4] 2> 2530408 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@4d205c92{/solr,null,UNAVAILABLE}
[junit4] 2> 2530428 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [ ]
o.e.j.s.ServerConnector Stopped ServerConnector@2eb3ee3{HTTP/1.1}{127.0.0.1:0}
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=879147856
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5ca743cd
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.u.UpdateHandler closing
DirectUpdateHandler2{commits=0,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 2530429 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 2530430 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 2530481 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2
directories currently being tracked
[junit4] 2> 2530481 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data;done=false>>]
[junit4] 2> 2530481 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data
[junit4] 2> 2530481 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data/index;done=false>>]
[junit4] 2> 2530481 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001/solr-instance-027/./collection1/data/index
[junit4] 2> 2530482 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[7B0BD13C5F474F3C]) [
x:collection1] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3325e933{/solr,null,UNAVAILABLE}
[junit4] 2> 2530483 INFO
(SUITE-TestReplicationHandler-seed#[7B0BD13C5F474F3C]-worker) [ ]
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/J2/temp/solr.handler.TestReplicationHandler_7B0BD13C5F474F3C-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene54):
{name=BlockTreeOrds(blocksize=128), id=BlockTreeOrds(blocksize=128),
newname=BlockTreeOrds(blocksize=128)}, docValues:{},
sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=zh_CN,
timezone=America/North_Dakota/Beulah
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_45 (64-bit)/cpus=4,threads=1,free=179469176,total=522715136
[junit4] 2> NOTE: All tests run in this JVM: [TestGroupingSearch,
TestXIncludeConfig, SuggesterTSTTest, FullSolrCloudDistribCmdsTest,
TestScoreJoinQPNoScore, CurrencyFieldXmlFileTest, TestSearchPerf,
TestPostingsSolrHighlighter, AnalyticsMergeStrategyTest, OverseerTest,
CloudMLTQParserTest, DirectUpdateHandlerOptimizeTest, SecurityConfHandlerTest,
SolrCoreCheckLockOnStartupTest, CloudExitableDirectoryReaderTest,
SearchHandlerTest, HdfsSyncSliceTest, TestLeaderInitiatedRecoveryThread,
TestLeaderElectionZkExpiry, OverseerCollectionConfigSetProcessorTest,
TestLRUCache, TestIndexSearcher, TestMinMaxOnMultiValuedField, SampleTest,
ResponseHeaderTest, BlockCacheTest, TestReplicationHandlerBackup,
TestManagedStopFilterFactory, TestConfigSetsAPI, TestSolrQueryParser,
TestReqParamsAPI, HdfsWriteToMultipleCollectionsTest, OverseerStatusTest,
TestSolrIndexConfig, TestStressRecovery, TestConfigSetsAPIExclusivity,
ClusterStateTest, HLLSerializationTest, TestFastWriter,
TestManagedResourceStorage, ConcurrentDeleteAndCreateCollectionTest,
FacetPivotSmallTest, RequestHandlersTest, TestSolrCLIRunExample,
MultiThreadedOCPTest, TestMiniSolrCloudClusterBase, SolrTestCaseJ4Test,
TestElisionMultitermQuery, BigEndianAscendingWordDeserializerTest,
DistributedFacetPivotSmallTest, UUIDFieldTest, FieldAnalysisRequestHandlerTest,
FieldMutatingUpdateProcessorTest, CoreAdminHandlerTest, AddBlockUpdateTest,
SystemInfoHandlerTest, QueryResultKeyTest, ZkNodePropsTest,
RegexBoostProcessorTest, TestRandomRequestDistribution, BadIndexSchemaTest,
TestTrieFacet, UpdateParamsTest, TestJsonFacets, TestDownShardTolerantSearch,
BinaryUpdateRequestHandlerTest, PrimitiveFieldTypeTest, DocValuesMissingTest,
ScriptEngineTest, CdcrUpdateLogTest, TestQueryWrapperFilter,
TestIndexingPerformance, TestScoreJoinQPScore, TestPerFieldSimilarity,
SimpleFacetsTest, TestShardHandlerFactory, StatsComponentTest,
TestManagedSchemaDynamicFieldResource, HardAutoCommitTest,
TestCSVResponseWriter, BasicAuthIntegrationTest,
TestDistributedStatsComponentCardinality, LukeRequestHandlerTest,
SimpleMLTQParserTest, AsyncCallRequestStatusResponseTest,
TestReloadAndDeleteDocs, TestAuthenticationFramework, TestRecovery,
TestHashQParserPlugin, BasicDistributedZkTest, BasicDistributedZk2Test,
UnloadDistributedZkTest, SyncSliceTest, ShardRoutingTest, RecoveryZkTest,
TestReplicationHandler]
[junit4] Completed [296/553] on J2 in 681.83s, 13 tests, 1 failure <<<
FAILURES!
[...truncated 818 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:782:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:719:
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: 553 suites (8 ignored), 2176 tests, 2 errors, 1
failure, 31 ignored (18 assumptions) [seed: 7B0BD13C5F474F3C]
Total time: 204 minutes 27 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: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
