Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/633/

2 tests failed.
FAILED:  
org.apache.solr.cloud.CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap

Error Message:
Document mismatch on target after sync expected:<10000> but was:<0>

Stack Trace:
java.lang.AssertionError: Document mismatch on target after sync 
expected:<10000> but was:<0>
        at 
__randomizedtesting.SeedInfo.seed([8B2F311CA3C501F7:5CF81E6B179A99B0]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.failNotEquals(Assert.java:647)
        at org.junit.Assert.assertEquals(Assert.java:128)
        at org.junit.Assert.assertEquals(Assert.java:472)
        at 
org.apache.solr.cloud.CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap(CdcrBootstrapTest.java:134)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)


FAILED:  org.apache.solr.metrics.reporters.SolrGangliaReporterTest.testReporter

Error Message:


Stack Trace:
java.util.ConcurrentModificationException
        at 
__randomizedtesting.SeedInfo.seed([8B2F311CA3C501F7:D4CB1C2BC8C992B2]:0)
        at java.util.ArrayList$Itr.checkForComodification(ArrayList.java:901)
        at java.util.ArrayList$Itr.next(ArrayList.java:851)
        at 
org.apache.solr.metrics.reporters.SolrGangliaReporterTest.testReporter(SolrGangliaReporterTest.java:76)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11071 lines...]
   [junit4] Suite: org.apache.solr.metrics.reporters.SolrGangliaReporterTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.SolrGangliaReporterTest_8B2F311CA3C501F7-001/init-core-data-001
   [junit4]   2> 341134 INFO  
(SUITE-SolrGangliaReporterTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 341152 INFO  
(TEST-SolrGangliaReporterTest.testReporter-seed#[8B2F311CA3C501F7]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testReporter
   [junit4]   2> 341547 INFO  
(TEST-SolrGangliaReporterTest.testReporter-seed#[8B2F311CA3C501F7]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=600000&connTimeout=60000&retry=true
   [junit4]   2> 341561 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, 
from paths: 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/lib,
 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 341604 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 341633 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 341745 WARN  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] default search field in schema 
is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 341747 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 341754 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1
   [junit4]   2> 341755 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/core/src/test-files/solr/collection1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.SolrGangliaReporterTest_8B2F311CA3C501F7-001/init-core-data-001/]
   [junit4]   2> 341755 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr 
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@39c4eeb3
   [junit4]   2> 341758 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=26, maxMergeAtOnceExplicit=27, maxMergedSegmentMB=39.623046875, 
floorSegmentMB=1.5439453125, forceMergeDeletesPctAllowed=26.44465566710687, 
segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7921434722295806
   [junit4]   2> 341778 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 341778 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 341779 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 341779 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 341779 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=36, maxMergeAtOnceExplicit=20, maxMergedSegmentMB=91.8701171875, 
floorSegmentMB=1.705078125, forceMergeDeletesPctAllowed=0.5806820222889741, 
segmentsPerTier=18.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 341781 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@773df2d9[collection1] main]
   [junit4]   2> 341781 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 341789 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 341822 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 341822 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: 
multipleFields
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 341823 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 341824 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 341824 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 341824 INFO  
(searcherExecutor-1577-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@773df2d9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 341825 INFO  (coreLoadExecutor-1576-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1555050460541353984
   [junit4]   2> 346840 INFO  
(TEST-SolrGangliaReporterTest.testReporter-seed#[8B2F311CA3C501F7]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testReporter
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=SolrGangliaReporterTest -Dtests.method=testReporter 
-Dtests.seed=8B2F311CA3C501F7 -Dtests.multiplier=2 -Dtests.slow=true 
-Dtests.locale=pt -Dtests.timezone=Australia/North -Dtests.asserts=true 
-Dtests.file.encoding=US-ASCII
   [junit4] ERROR   5.71s J0 | SolrGangliaReporterTest.testReporter <<<
   [junit4]    > Throwable #1: java.util.ConcurrentModificationException
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8B2F311CA3C501F7:D4CB1C2BC8C992B2]:0)
   [junit4]    >        at 
java.util.ArrayList$Itr.checkForComodification(ArrayList.java:901)
   [junit4]    >        at java.util.ArrayList$Itr.next(ArrayList.java:851)
   [junit4]    >        at 
org.apache.solr.metrics.reporters.SolrGangliaReporterTest.testReporter(SolrGangliaReporterTest.java:76)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 346843 INFO  
(SUITE-SolrGangliaReporterTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 346843 INFO  
(SUITE-SolrGangliaReporterTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1953605422
   [junit4]   2> 346843 INFO  (coreCloseExecutor-1582-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3b7dae0c
   [junit4]   2> 346853 INFO  (coreCloseExecutor-1582-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 346854 INFO  
(SUITE-SolrGangliaReporterTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J0/temp/solr.metrics.reporters.SolrGangliaReporterTest_8B2F311CA3C501F7-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, 
sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=pt, 
timezone=Australia/North
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_102 (64-bit)/cpus=4,threads=1,free=238540520,total=472383488
   [junit4]   2> NOTE: All tests run in this JVM: 
[DocumentAnalysisRequestHandlerTest, AlternateDirectoryTest, TestCSVLoader, 
TestSolrCoreProperties, DistributedSpellCheckComponentTest, 
TestConfigSetImmutable, TemplateUpdateProcessorTest, 
ReplicaListTransformerTest, SynonymTokenizerTest, TestSmileRequest, 
TestImplicitCoreProperties, LeaderElectionIntegrationTest, ScriptEngineTest, 
TestScoreJoinQPNoScore, RollingRestartTest, TestCrossCoreJoin, 
QueryResultKeyTest, TestChildDocTransformer, DistributedFacetPivotLargeTest, 
TestDocSet, TestCorePropertiesReload, 
TestPerFieldSimilarityWithDefaultOverride, SolrRequestParserTest, 
TestSerializedLuceneMatchVersion, ConcurrentDeleteAndCreateCollectionTest, 
CollectionTooManyReplicasTest, SignatureUpdateProcessorFactoryTest, 
BlockCacheTest, CloudMLTQParserTest, TestBulkSchemaConcurrent, 
TestFieldTypeCollectionResource, DisMaxRequestHandlerTest, 
TestCustomDocTransformer, DistributedDebugComponentTest, 
StandardRequestHandlerTest, DistribDocExpirationUpdateProcessorTest, 
FastVectorHighlighterTest, OverseerRolesTest, TestFileDictionaryLookup, 
TestNRTOpen, PathHierarchyTokenizerFactoryTest, TestSolrDeletionPolicy2, 
TestSolrConfigHandler, ExternalFileFieldSortTest, QueryEqualityTest, 
SolrGangliaReporterTest]
   [junit4] Completed [126/675 (1!)] on J0 in 5.77s, 1 test, 1 error <<< 
FAILURES!

[...truncated 1171 lines...]
   [junit4] Suite: org.apache.solr.cloud.CdcrBootstrapTest
   [junit4]   2> Creating dataDir: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/init-core-data-001
   [junit4]   2> 1375988 INFO  
(SUITE-CdcrBootstrapTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 1375990 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testConvertClusterToCdcrAndBootstrap
   [junit4]   2> 1375990 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-target-001
   [junit4]   2> 1375990 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1375990 INFO  (Thread-3214) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1375990 INFO  (Thread-3214) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1376090 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.ZkTestServer start zk server on port:40275
   [junit4]   2> 1376104 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1376111 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@2ae67b99{/solr,null,AVAILABLE}
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@358c975b{HTTP/1.1,[http/1.1]}{127.0.0.1:50499}
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.e.j.s.Server Started @1380625ms
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50499}
   [junit4]   2> 1376112 ERROR (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.0
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1376112 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-29T11:58:39.685Z
   [junit4]   2> 1376115 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1376124 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1376125 INFO  (jetty-launcher-1754-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:40275/solr
   [junit4]   2> 1376146 INFO  (jetty-launcher-1754-thread-1) 
[n:127.0.0.1:50499_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:50499_solr
   [junit4]   2> 1376147 INFO  (jetty-launcher-1754-thread-1) 
[n:127.0.0.1:50499_solr    ] o.a.s.c.Overseer Overseer 
(id=97190721589346307-127.0.0.1:50499_solr-n_0000000000) starting
   [junit4]   2> 1376153 INFO  (jetty-launcher-1754-thread-1) 
[n:127.0.0.1:50499_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50499_solr
   [junit4]   2> 1376156 INFO  
(zkCallback-1760-thread-1-processing-n:127.0.0.1:50499_solr) 
[n:127.0.0.1:50499_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1376229 INFO  (jetty-launcher-1754-thread-1) 
[n:127.0.0.1:50499_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-target-001/node1/.
   [junit4]   1> Target zkHost = 127.0.0.1:40275/solr
   [junit4]   2> 1376884 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-source-001
   [junit4]   2> 1376884 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1376885 INFO  (Thread-3224) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1376885 INFO  (Thread-3224) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1376892 WARN  (Thread-3224) [    ] o.a.z.j.MBeanRegistry 
Failed to register MBean StandaloneServer_port-1
   [junit4]   2> 1376892 WARN  (Thread-3224) [    ] o.a.z.s.ZooKeeperServer 
Failed to register with JMX
   [junit4]   2> javax.management.InstanceAlreadyExistsException: 
org.apache.ZooKeeperService:name0=StandaloneServer_port-1
   [junit4]   2>        at 
com.sun.jmx.mbeanserver.Repository.addMBean(Repository.java:437)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerWithRepository(DefaultMBeanServerInterceptor.java:1898)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerDynamicMBean(DefaultMBeanServerInterceptor.java:966)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerObject(DefaultMBeanServerInterceptor.java:900)
   [junit4]   2>        at 
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.registerMBean(DefaultMBeanServerInterceptor.java:324)
   [junit4]   2>        at 
com.sun.jmx.mbeanserver.JmxMBeanServer.registerMBean(JmxMBeanServer.java:522)
   [junit4]   2>        at 
org.apache.zookeeper.jmx.MBeanRegistry.register(MBeanRegistry.java:96)
   [junit4]   2>        at 
org.apache.zookeeper.server.ZooKeeperServer.registerJMX(ZooKeeperServer.java:377)
   [junit4]   2>        at 
org.apache.zookeeper.server.ZooKeeperServer.startup(ZooKeeperServer.java:410)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.startup(NIOServerCnxnFactory.java:123)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkTestServer$ZKServerMain.runFromConfig(ZkTestServer.java:308)
   [junit4]   2>        at 
org.apache.solr.cloud.ZkTestServer$2.run(ZkTestServer.java:490)
   [junit4]   2> 1376985 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.ZkTestServer start zk server on port:36822
   [junit4]   2> 1376993 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1376998 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5e666d62{/solr,null,AVAILABLE}
   [junit4]   2> 1376998 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@410c6373{HTTP/1.1,[http/1.1]}{127.0.0.1:50997}
   [junit4]   2> 1376998 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.e.j.s.Server Started @1381511ms
   [junit4]   2> 1376998 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=50997}
   [junit4]   2> 1376998 ERROR (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1376999 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.0
   [junit4]   2> 1376999 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1376999 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1376999 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-12-29T11:58:40.572Z
   [junit4]   2> 1377002 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1377020 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1377021 INFO  (jetty-launcher-1765-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:36822/solr
   [junit4]   2> 1377078 INFO  (jetty-launcher-1765-thread-1) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:50997_solr
   [junit4]   2> 1377079 INFO  (jetty-launcher-1765-thread-1) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.Overseer Overseer 
(id=97190721648263171-127.0.0.1:50997_solr-n_0000000000) starting
   [junit4]   2> 1377093 INFO  (jetty-launcher-1765-thread-1) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:50997_solr
   [junit4]   2> 1377096 INFO  
(zkCallback-1771-thread-1-processing-n:127.0.0.1:50997_solr) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1377131 INFO  (jetty-launcher-1765-thread-1) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-source-001/node1/.
   [junit4]   2> 1377589 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 1377590 INFO  
(TEST-CdcrBootstrapTest.testConvertClusterToCdcrAndBootstrap-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 
127.0.0.1:36822/solr ready
   [junit4]   2> 1377592 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=cdcr-source&name=cdcr-source&action=CREATE&numShards=1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1377596 INFO  
(OverseerThreadFactory-5381-thread-1-processing-n:127.0.0.1:50997_solr) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
cdcr-source
   [junit4]   2> 1377703 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&name=cdcr-source_shard1_replica1&action=CREATE&numShards=1&collection=cdcr-source&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2
   [junit4]   2> 1377808 INFO  
(zkCallback-1771-thread-2-processing-n:127.0.0.1:50997_solr) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1378715 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.4.0
   [junit4]   2> 1378728 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.s.IndexSchema 
[cdcr-source_shard1_replica1] Schema name=minimal
   [junit4]   2> 1378731 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.s.IndexSchema 
Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 1378732 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.CoreContainer 
Creating SolrCore 'cdcr-source_shard1_replica1' using configuration from 
collection cdcr-source
   [junit4]   2> 1378733 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore 
[[cdcr-source_shard1_replica1] ] Opening new SolrCore at 
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-source-001/node1/cdcr-source_shard1_replica1],
 
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001/cdcr-source-001/node1/./cdcr-source_shard1_replica1/data/]
   [junit4]   2> 1378754 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1378754 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1378755 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 1378755 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 1378756 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@10c63fdb[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1378757 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/cdcr-source
   [junit4]   2> 1378757 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/cdcr-source
   [junit4]   2> 1378757 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1378757 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.u.UpdateLog Could 
not find max version in index or recent updates, using new clock 
1555051548329902080
   [junit4]   2> 1378764 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 1378764 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 1378764 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:50997/solr/cdcr-source_shard1_replica1/
   [junit4]   2> 1378765 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 1378765 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SyncStrategy 
http://127.0.0.1:50997/solr/cdcr-source_shard1_replica1/ has no replicas
   [junit4]   2> 1378765 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore 
[cdcr-source_shard1_replica1] Registered new searcher 
Searcher@10c63fdb[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1378775 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:50997/solr/cdcr-source_shard1_replica1/ shard1
   [junit4]   2> 1378878 INFO  
(zkCallback-1771-thread-3-processing-n:127.0.0.1:50997_solr) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1378926 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 1378931 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1  x:cdcr-source_shard1_replica1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=cdcr-source&newCollection=true&name=cdcr-source_shard1_replica1&action=CREATE&numShards=1&collection=cdcr-source&shard=shard1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2}
 status=0 QTime=1227
   [junit4]   2> 1378939 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr    
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 1379031 INFO  
(zkCallback-1771-thread-1-processing-n:127.0.0.1:50997_solr) 
[n:127.0.0.1:50997_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-source/state.json] for collection [cdcr-source] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1379598 INFO  
(OverseerCollectionConfigSetProcessor-97190721648263171-127.0.0.1:50997_solr-n_0000000000)
 [n:127.0.0.1:50997_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 1379940 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=cdcr-source&name=cdcr-source&action=CREATE&numShards=1&property.solr.directoryFactory=solr.StandardDirectoryFactory&wt=javabin&version=2}
 status=0 QTime=2347
   [junit4]   1> Adding 100 docs with commit=true, numDocs=100
   [junit4]   2> 1379949 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_0 
(1555051549575610368), source_1 (1555051549576658944), source_2 
(1555051549577707520), source_3 (1555051549577707521), source_4 
(1555051549577707522), source_5 (1555051549577707523), source_6 
(1555051549577707524), source_7 (1555051549577707525), source_8 
(1555051549577707526), source_9 (1555051549577707527), ... (100 adds)]} 0 4
   [junit4]   2> 1379951 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1379951 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1379990 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@67aa6087[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1379991 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1379991 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@67aa6087[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)))}
   [junit4]   2> 1379991 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 39
   [junit4]   1> Adding 100 docs with commit=true, numDocs=200
   [junit4]   2> 1379997 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_100 
(1555051549625942016), source_101 (1555051549628039168), source_102 
(1555051549628039169), source_103 (1555051549628039170), source_104 
(1555051549628039171), source_105 (1555051549628039172), source_106 
(1555051549628039173), source_107 (1555051549628039174), source_108 
(1555051549628039175), source_109 (1555051549628039176), ... (100 adds)]} 0 4
   [junit4]   2> 1379999 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1379999 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380040 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@69346b3a[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380040 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@69346b3a[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100)))}
   [junit4]   2> 1380040 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380041 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 41
   [junit4]   1> Adding 100 docs with commit=true, numDocs=300
   [junit4]   2> 1380046 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_200 
(1555051549678370816), source_201 (1555051549679419392), source_202 
(1555051549679419393), source_203 (1555051549679419394), source_204 
(1555051549679419395), source_205 (1555051549679419396), source_206 
(1555051549679419397), source_207 (1555051549679419398), source_208 
(1555051549679419399), source_209 (1555051549679419400), ... (100 adds)]} 0 3
   [junit4]   2> 1380048 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380048 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380083 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5e563fdb[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380083 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@5e563fdb[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100)))}
   [junit4]   2> 1380084 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380084 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 35
   [junit4]   1> Adding 100 docs with commit=true, numDocs=400
   [junit4]   2> 1380089 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_300 
(1555051549723459584), source_301 (1555051549724508160), source_302 
(1555051549724508161), source_303 (1555051549724508162), source_304 
(1555051549724508163), source_305 (1555051549724508164), source_306 
(1555051549724508165), source_307 (1555051549724508166), source_308 
(1555051549724508167), source_309 (1555051549724508168), ... (100 adds)]} 0 3
   [junit4]   2> 1380091 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380091 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380125 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5f689d47[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380125 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380126 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@5f689d47[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100)))}
   [junit4]   2> 1380126 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 35
   [junit4]   1> Adding 100 docs with commit=true, numDocs=500
   [junit4]   2> 1380132 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_400 
(1555051549768548352), source_401 (1555051549769596928), source_402 
(1555051549769596929), source_403 (1555051549769596930), source_404 
(1555051549769596931), source_405 (1555051549769596932), source_406 
(1555051549769596933), source_407 (1555051549769596934), source_408 
(1555051549769596935), source_409 (1555051549769596936), ... (100 adds)]} 0 3
   [junit4]   2> 1380134 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380134 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380189 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@229d4c5c[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380190 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@229d4c5c[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100)))}
   [junit4]   2> 1380190 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380190 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 55
   [junit4]   1> Adding 100 docs with commit=true, numDocs=600
   [junit4]   2> 1380196 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_500 
(1555051549834608640), source_501 (1555051549835657216), source_502 
(1555051549835657217), source_503 (1555051549835657218), source_504 
(1555051549835657219), source_505 (1555051549835657220), source_506 
(1555051549835657221), source_507 (1555051549835657222), source_508 
(1555051549835657223), source_509 (1555051549835657224), ... (100 adds)]} 0 3
   [junit4]   2> 1380198 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380198 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380256 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2084a8e1[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380257 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@2084a8e1[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100) 
Uninverting(_5(6.4.0):C100)))}
   [junit4]   2> 1380257 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380257 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 59
   [junit4]   1> Adding 100 docs with commit=true, numDocs=700
   [junit4]   2> 1380263 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_600 
(1555051549904863232), source_601 (1555051549905911808), source_602 
(1555051549905911809), source_603 (1555051549905911810), source_604 
(1555051549905911811), source_605 (1555051549905911812), source_606 
(1555051549905911813), source_607 (1555051549905911814), source_608 
(1555051549905911815), source_609 (1555051549906960384), ... (100 adds)]} 0 3
   [junit4]   2> 1380264 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380265 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380312 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7841e56a[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380313 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@7841e56a[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100) 
Uninverting(_5(6.4.0):C100) Uninverting(_6(6.4.0):C100)))}
   [junit4]   2> 1380313 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380313 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 48
   [junit4]   1> Adding 100 docs with commit=true, numDocs=800
   [junit4]   2> 1380319 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_700 
(1555051549963583488), source_701 (1555051549964632064), source_702 
(1555051549964632065), source_703 (1555051549964632066), source_704 
(1555051549964632067), source_705 (1555051549964632068), source_706 
(1555051549965680640), source_707 (1555051549965680641), source_708 
(1555051549965680642), source_709 (1555051549965680643), ... (100 adds)]} 0 3
   [junit4]   2> 1380321 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380321 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380393 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@fcc244d[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380393 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@fcc244d[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100) 
Uninverting(_5(6.4.0):C100) Uninverting(_6(6.4.0):C100) 
Uninverting(_7(6.4.0):C100)))}
   [junit4]   2> 1380393 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380394 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 73
   [junit4]   1> Adding 100 docs with commit=true, numDocs=900
   [junit4]   2> 1380415 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_800 
(1555051550059003904), source_801 (1555051550060052480), source_802 
(1555051550060052481), source_803 (1555051550060052482), source_804 
(1555051550060052483), source_805 (1555051550060052484), source_806 
(1555051550060052485), source_807 (1555051550060052486), source_808 
(1555051550060052487), source_809 (1555051550060052488), ... (100 adds)]} 0 9
   [junit4]   2> 1380417 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380417 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380490 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@79eeb96d[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380505 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@79eeb96d[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100) 
Uninverting(_5(6.4.0):C100) Uninverting(_6(6.4.0):C100) 
Uninverting(_7(6.4.0):C100) Uninverting(_8(6.4.0):C100)))}
   [junit4]   2> 1380505 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380505 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 87
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1000
   [junit4]   2> 1380516 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_900 
(1555051550171201536), source_901 (1555051550172250112), source_902 
(1555051550172250113), source_903 (1555051550172250114), source_904 
(1555051550172250115), source_905 (1555051550172250116), source_906 
(1555051550172250117), source_907 (1555051550172250118), source_908 
(1555051550172250119), source_909 (1555051550172250120), ... (100 adds)]} 0 3
   [junit4]   2> 1380518 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380518 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380581 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@d3ce9bc[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380582 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380582 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@d3ce9bc[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C100)
 Uninverting(_1(6.4.0):C100) Uninverting(_2(6.4.0):C100) 
Uninverting(_3(6.4.0):C100) Uninverting(_4(6.4.0):C100) 
Uninverting(_5(6.4.0):C100) Uninverting(_6(6.4.0):C100) 
Uninverting(_7(6.4.0):C100) Uninverting(_8(6.4.0):C100) 
Uninverting(_9(6.4.0):C100)))}
   [junit4]   2> 1380582 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 64
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1100
   [junit4]   2> 1380588 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1000 
(1555051550245650432), source_1001 (1555051550247747584), source_1002 
(1555051550247747585), source_1003 (1555051550247747586), source_1004 
(1555051550247747587), source_1005 (1555051550247747588), source_1006 
(1555051550247747589), source_1007 (1555051550247747590), source_1008 
(1555051550247747591), source_1009 (1555051550247747592), ... (100 adds)]} 0 3
   [junit4]   2> 1380590 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380590 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380662 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@64f6347f[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380663 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380663 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@64f6347f[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100)))}
   [junit4]   2> 1380665 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 74
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1200
   [junit4]   2> 1380670 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1100 
(1555051550332682240), source_1101 (1555051550333730816), source_1102 
(1555051550333730817), source_1103 (1555051550333730818), source_1104 
(1555051550333730819), source_1105 (1555051550333730820), source_1106 
(1555051550333730821), source_1107 (1555051550333730822), source_1108 
(1555051550333730823), source_1109 (1555051550333730824), ... (100 adds)]} 0 3
   [junit4]   2> 1380672 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380672 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380766 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@49b927a[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380766 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@49b927a[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100)))}
   [junit4]   2> 1380766 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380767 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 94
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1300
   [junit4]   2> 1380772 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1200 
(1555051550439636992), source_1201 (1555051550440685568), source_1202 
(1555051550440685569), source_1203 (1555051550440685570), source_1204 
(1555051550440685571), source_1205 (1555051550440685572), source_1206 
(1555051550440685573), source_1207 (1555051550440685574), source_1208 
(1555051550440685575), source_1209 (1555051550440685576), ... (100 adds)]} 0 3
   [junit4]   2> 1380774 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380774 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380821 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3c083625[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380821 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@3c083625[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100)))}
   [junit4]   2> 1380822 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380822 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 47
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1400
   [junit4]   2> 1380827 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1300 
(1555051550497308672), source_1301 (1555051550498357248), source_1302 
(1555051550498357249), source_1303 (1555051550498357250), source_1304 
(1555051550498357251), source_1305 (1555051550498357252), source_1306 
(1555051550498357253), source_1307 (1555051550498357254), source_1308 
(1555051550498357255), source_1309 (1555051550498357256), ... (100 adds)]} 0 3
   [junit4]   2> 1380829 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380829 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380881 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@110a38b2[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380882 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@110a38b2[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100)))}
   [junit4]   2> 1380882 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380882 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 52
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1500
   [junit4]   2> 1380888 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1400 
(1555051550560223232), source_1401 (1555051550561271808), source_1402 
(1555051550561271809), source_1403 (1555051550561271810), source_1404 
(1555051550561271811), source_1405 (1555051550561271812), source_1406 
(1555051550561271813), source_1407 (1555051550561271814), source_1408 
(1555051550561271815), source_1409 (1555051550561271816), ... (100 adds)]} 0 3
   [junit4]   2> 1380889 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380889 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380928 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@8536696[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380929 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@8536696[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100) 
Uninverting(_f(6.4.0):C100)))}
   [junit4]   2> 1380929 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380929 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 39
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1600
   [junit4]   2> 1380934 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1500 
(1555051550609506304), source_1501 (1555051550610554880), source_1502 
(1555051550610554881), source_1503 (1555051550610554882), source_1504 
(1555051550610554883), source_1505 (1555051550610554884), source_1506 
(1555051550610554885), source_1507 (1555051550610554886), source_1508 
(1555051550610554887), source_1509 (1555051550610554888), ... (100 adds)]} 0 3
   [junit4]   2> 1380936 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380936 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1380984 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2b664f8d[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1380985 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@2b664f8d[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100) 
Uninverting(_f(6.4.0):C100) Uninverting(_g(6.4.0):C100)))}
   [junit4]   2> 1380985 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1380985 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 48
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1700
   [junit4]   2> 1380991 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1600 
(1555051550668226560), source_1601 (1555051550669275136), source_1602 
(1555051550669275137), source_1603 (1555051550669275138), source_1604 
(1555051550669275139), source_1605 (1555051550669275140), source_1606 
(1555051550669275141), source_1607 (1555051550669275142), source_1608 
(1555051550669275143), source_1609 (1555051550669275144), ... (100 adds)]} 0 3
   [junit4]   2> 1380992 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1380992 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1381036 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@63f2e37b[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1381036 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@63f2e37b[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100) 
Uninverting(_f(6.4.0):C100) Uninverting(_g(6.4.0):C100) 
Uninverting(_h(6.4.0):C100)))}
   [junit4]   2> 1381037 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1381037 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 44
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1800
   [junit4]   2> 1381042 INFO  (qtp1549865715-11468) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1700 
(1555051550722752512), source_1701 (1555051550723801088), source_1702 
(1555051550723801089), source_1703 (1555051550723801090), source_1704 
(1555051550723801091), source_1705 (1555051550723801092), source_1706 
(1555051550723801093), source_1707 (1555051550723801094), source_1708 
(1555051550723801095), source_1709 (1555051550723801096), ... (100 adds)]} 0 3
   [junit4]   2> 1381044 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1381044 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1381086 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4411f713[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1381087 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@4411f713[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100) 
Uninverting(_f(6.4.0):C100) Uninverting(_g(6.4.0):C100) 
Uninverting(_h(6.4.0):C100) Uninverting(_i(6.4.0):C100)))}
   [junit4]   2> 1381087 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1381087 INFO  (qtp1549865715-11473) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 42
   [junit4]   1> Adding 100 docs with commit=true, numDocs=1900
   [junit4]   2> 1381093 INFO  (qtp1549865715-11469) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1800 
(1555051550775181312), source_1801 (1555051550776229888), source_1802 
(1555051550776229889), source_1803 (1555051550776229890), source_1804 
(1555051550776229891), source_1805 (1555051550776229892), source_1806 
(1555051550776229893), source_1807 (1555051550776229894), source_1808 
(1555051550776229895), source_1809 (1555051550776229896), ... (100 adds)]} 0 3
   [junit4]   2> 1381097 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1381097 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@401697b1
   [junit4]   2> 1381149 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@12a70847[cdcr-source_shard1_replica1] main]
   [junit4]   2> 1381150 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1381150 INFO  
(searcherExecutor-5384-thread-1-processing-n:127.0.0.1:50997_solr 
x:cdcr-source_shard1_replica1 s:shard1 c:cdcr-source r:core_node1) 
[n:127.0.0.1:50997_solr c:cdcr-source s:shard1 r:core_node1 
x:cdcr-source_shard1_replica1] o.a.s.c.SolrCore [cdcr-source_shard1_replica1] 
Registered new searcher Searcher@12a70847[cdcr-source_shard1_replica1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_b(6.4.0):C1000)
 Uninverting(_a(6.4.0):C100) Uninverting(_c(6.4.0):C100) 
Uninverting(_d(6.4.0):C100) Uninverting(_e(6.4.0):C100) 
Uninverting(_f(6.4.0):C100) Uninverting(_g(6.4.0):C100) 
Uninverting(_h(6.4.0):C100) Uninverting(_i(6.4.0):C100) 
Uninverting(_j(6.4.0):C100)))}
   [junit4]   2> 1381150 INFO  (qtp1549865715-11471) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 53
   [junit4]   1> Adding 100 docs with commit=true, numDocs=2000
   [junit4]   2> 1381156 INFO  (qtp1549865715-11472) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.p.LogUpdateProcessorFactory [cdcr-source_shard1_replica1]  webapp=/solr 
path=/update 
params={_stateVer_=cdcr-source:3&wt=javabin&version=2}{add=[source_1900 
(1555051550841241600), source_1901 (1555051550842290176), source_1902 
(1555051550842290177), source_1903 (1555051550842290178), source_1904 
(1555051550842290179), source_1905 (1555051550843338752), source_1906 
(1555051550843338753), source_1907 (1555051550843338754), source_1908 
(1555051550843338755), source_1909 (1555051550843338756), ... (100 adds)]} 0 3
   [junit4]   2> 1381157 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_replica1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1381158 INFO  (qtp1549865715-11475) [n:127.0.0.1:50997_solr 
c:cdcr-source s:shard1 r:core_node1 x:cdcr-source_shard1_re

[...truncated too long message...]

12) [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:35643 35643
   [junit4]   2> 1561730 WARN  (Thread-3312) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/aliases.json
   [junit4]   2>        2       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        2       /solr/clusterstate.json
   [junit4]   2>        2       /solr/collections/cdcr-source/cdcr/state/process
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        19      /solr/overseer/collection-queue-work
   [junit4]   2>        11      /solr/overseer/queue
   [junit4]   2>        3       /solr/overseer/queue-work
   [junit4]   2>        2       /solr/live_nodes
   [junit4]   2>        2       /solr/collections
   [junit4]   2> 
   [junit4]   2> 1561732 INFO  (jetty-launcher-1826-thread-1) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@6a24503e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1561732 INFO  (jetty-launcher-1826-thread-1) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=747556721
   [junit4]   2> 1561733 INFO  (coreCloseExecutor-5538-thread-1) 
[n:127.0.0.1:52943_solr c:cdcr-target s:shard1 r:core_node1 
x:cdcr-target_shard1_replica1] o.a.s.c.SolrCore [cdcr-target_shard1_replica1]  
CLOSING SolrCore org.apache.solr.core.SolrCore@1e9124f9
   [junit4]   2> 1561734 INFO  (coreCloseExecutor-5538-thread-1) 
[n:127.0.0.1:52943_solr c:cdcr-target s:shard1 r:core_node1 
x:cdcr-target_shard1_replica1] o.a.s.h.CdcrRequestHandler Solr core is being 
closed - shutting down CDCR handler @ cdcr-target:shard1
   [junit4]   2> 1561735 INFO  
(zkCallback-1832-thread-1-processing-n:127.0.0.1:52943_solr) 
[n:127.0.0.1:52943_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/cdcr-target/state.json] for collection [cdcr-target] has 
occurred - updating... (live nodes size: [1])
   [junit4]   2> 1561744 INFO  (coreCloseExecutor-5538-thread-1) 
[n:127.0.0.1:52943_solr c:cdcr-target s:shard1 r:core_node1 
x:cdcr-target_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric 
reporters for: solr.core.cdcr-target.shard1.replica1
   [junit4]   2> 1561744 INFO  (jetty-launcher-1826-thread-1) [    ] 
o.a.s.c.Overseer Overseer 
(id=97190732320931843-127.0.0.1:52943_solr-n_0000000000) closing
   [junit4]   2> 1561745 INFO  
(OverseerStateUpdate-97190732320931843-127.0.0.1:52943_solr-n_0000000000) 
[n:127.0.0.1:52943_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:52943_solr
   [junit4]   2> 1563249 WARN  
(zkCallback-1832-thread-1-processing-n:127.0.0.1:52943_solr) 
[n:127.0.0.1:52943_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1563249 INFO  (jetty-launcher-1826-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1563250 INFO  (jetty-launcher-1826-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3cd27aa9{/solr,null,UNAVAILABLE}
   [junit4]   2> 1563251 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:55589 55589
   [junit4]   2> 1563353 INFO  (Thread-3302) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:55589 55589
   [junit4]   2> 1563354 WARN  (Thread-3302) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        5       /solr/configs/cdcr-target/managed-schema
   [junit4]   2>        5       
/solr/collections/cdcr-target/leaders/shard1/leader
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        6       /solr/collections/cdcr-target/cdcr/state/process
   [junit4]   2>        5       /solr/collections/cdcr-target/cdcr/state/buffer
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        21      /solr/overseer/collection-queue-work
   [junit4]   2>        5       /solr/overseer/queue
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2>        2       /solr/overseer/queue-work
   [junit4]   2> 
   [junit4]   2> 1563354 INFO  
(TEST-CdcrBootstrapTest.testBootstrapWithContinousIndexingOnSourceCluster-seed#[8B2F311CA3C501F7])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending 
testBootstrapWithContinousIndexingOnSourceCluster
   [junit4]   2> 1563355 INFO  
(SUITE-CdcrBootstrapTest-seed#[8B2F311CA3C501F7]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.CdcrBootstrapTest_8B2F311CA3C501F7-001
   [junit4]   2> Dec 29, 2016 12:01:46 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{_version_=FSTOrd50, xyz=Lucene50(blocksize=128), 
id=PostingsFormat(name=MockRandom)}, docValues:{}, maxPointsInLeafNode=271, 
maxMBSortInHeap=7.373848684958709, 
sim=RandomSimilarity(queryNorm=false,coord=crazy): {}, locale=en-ZA, 
timezone=Africa/Djibouti
   [junit4]   2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 
1.8.0_102 (64-bit)/cpus=4,threads=1,free=194205648,total=531628032
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestWordDelimiterFilterFactory, TestLegacyFieldCache, 
DirectSolrConnectionTest, BlockDirectoryTest, RulesTest, 
TestUseDocValuesAsStored2, TestLockTree, SolrIndexConfigTest, TestCustomStream, 
IndexSchemaRuntimeFieldTest, TestSolrQueryParserDefaultOperatorResource, 
TestUpdate, DeleteNodeTest, TestManagedResource, TestMiniSolrCloudClusterSSL, 
TestSearchPerf, IndexBasedSpellCheckerTest, IndexSchemaTest, TestSearcherReuse, 
TestHashPartitioner, URLClassifyProcessorTest, TestSegmentSorting, 
TestExactSharedStatsCache, TestMissingGroups, TestConfigReload, 
TestDocBasedVersionConstraints, TestFastOutputStream, DocumentBuilderTest, 
LoggingHandlerTest, TestFuzzyAnalyzedSuggestions, SolrInfoMBeanTest, 
TestBackupRepositoryFactory, HLLUtilTest, CopyFieldTest, EchoParamsTest, 
HdfsChaosMonkeyNothingIsSafeTest, TestMacroExpander, TestHashQParserPlugin, 
SortByFunctionTest, SharedFSAutoReplicaFailoverTest, CustomCollectionTest, 
ReplicationFactorTest, TestCloudManagedSchema, StressHdfsTest, 
SuggesterFSTTest, DistributedFacetPivotWhiteBoxTest, 
CachingDirectoryFactoryTest, SolrCLIZkUtilsTest, TestCoreContainer, 
TestCursorMarkWithoutUniqueKey, TestFieldCollectionResource, MultiTermTest, 
TestManagedStopFilterFactory, TestSolrCoreSnapshots, 
TestSimpleTrackingShardHandler, BooleanFieldTest, TestSolrCLIRunExample, 
TestAuthenticationFramework, TestBM25SimilarityFactory, 
HdfsRestartWhileUpdatingTest, TestTolerantUpdateProcessorRandomCloud, 
TermVectorComponentTest, ExplicitHLLTest, JvmMetricsTest, 
ChaosMonkeySafeLeaderTest, TestMinMaxOnMultiValuedField, 
LeaderInitiatedRecoveryOnCommitTest, TestLRUCache, AliasIntegrationTest, 
FileUtilsTest, TestStressVersions, SampleTest, TestSystemIdResolver, 
SystemInfoHandlerTest, CollectionsAPIAsyncDistributedZkTest, 
TestRequestForwarding, BlockJoinFacetSimpleTest, SimplePostToolTest, 
TestReqParamsAPI, TestScoreJoinQPScore, TestFieldCacheReopen, ZkSolrClientTest, 
TestLuceneMatchVersion, TestDistributedGrouping, CSVRequestHandlerTest, 
ZkControllerTest, ShufflingReplicaListTransformerTest, TestRawTransformer, 
DistributedIntervalFacetingTest, DocValuesMissingTest, TestFreeTextSuggestions, 
DistribJoinFromCollectionTest, ShardRoutingTest, TestLeaderElectionZkExpiry, 
TestCollationFieldDocValues, TestSubQueryTransformer, 
TestDefaultSearchFieldResource, TestSurroundQueryParser, 
VMParamsZkACLAndCredentialsProvidersTest, BasicFunctionalityTest, TestTrie, 
TestStressCloudBlindAtomicUpdates, TestSchemaSimilarityResource, 
SuggestComponentTest, TestXmlQParserPlugin, CdcrReplicationHandlerTest, 
ConvertedLegacyTest, TestConfigSetProperties, HdfsNNFailoverTest, 
DistanceUnitsTest, TestNonDefinedSimilarityFactory, OpenCloseCoreStressTest, 
BasicDistributedZkTest, BasicDistributedZk2Test, 
CollectionsAPIDistributedZkTest, ClusterStateUpdateTest, TestRandomFaceting, 
ZkCLITest, TestDistributedSearch, SolrIndexSplitterTest, TestCoreDiscovery, 
CoreAdminHandlerTest, SuggesterTest, NoCacheHeaderTest, 
SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, 
DefaultValueUpdateProcessorTest, XsltUpdateRequestHandlerTest, TestQueryUtils, 
DirectSolrSpellCheckerTest, TestQueryTypes, PrimitiveFieldTypeTest, 
TermsComponentTest, RequestHandlersTest, TestIndexingPerformance, 
RequiredFieldsTest, TestSolrQueryParser, TestJmxIntegration, 
TestCSVResponseWriter, TestAnalyzedSuggestions, TestPartialUpdateDeduplication, 
SearchHandlerTest, UpdateParamsTest, TestQuerySenderNoQuery, 
TestElisionMultitermQuery, TestPostingsSolrHighlighter, TestCharFilters, 
TestSweetSpotSimilarityFactory, TestLMJelinekMercerSimilarityFactory, 
ResourceLoaderTest, DateMathParserTest, PrimUtilsTest, 
TestSuggestSpellingConverter, DateFieldTest, SpellingQueryConverterTest, 
RAMDirectoryFactoryTest, TestDocumentBuilder, ZkNodePropsTest, SliceStateTest, 
CircularListTest, DistributedMLTComponentTest, TestRTGBase, CursorPagingTest, 
SolrTestCaseJ4Test, TestDistributedMissingSort, TestHighlightDedupGrouping, 
TestEmbeddedSolrServerConstructors, TestJettySolrRunner, ActionThrottleTest, 
AssignTest, AsyncCallRequestStatusResponseTest, BaseCdcrDistributedZkTest, 
CdcrBootstrapTest]
   [junit4] Completed [493/675 (2!)] on J1 in 187.63s, 3 tests, 1 failure <<< 
FAILURES!

[...truncated 63077 lines...]


---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to