Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Windows/496/
Java: 32bit/jdk1.8.0_102 -client -XX:+UseG1GC

1 tests failed.
FAILED:  
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication

Error Message:
expected:<1> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
        at 
__randomizedtesting.SeedInfo.seed([8A116F9B1EED16C1:7D6281C3D805B927]: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.junit.Assert.assertEquals(Assert.java:456)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1331)
        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:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
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:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java: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 10680 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\init-core-data-001
   [junit4]   2> 59716 INFO  
(SUITE-TestReplicationHandler-seed#[8A116F9B1EED16C1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 59721 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
   [junit4]   2> 59723 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1
   [junit4]   2> 59765 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 59767 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5b59b{/solr,null,AVAILABLE}
   [junit4]   2> 59771 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@166af30{HTTP/1.1,[http/1.1]}{127.0.0.1:50441}
   [junit4]   2> 59771 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @63722ms
   [junit4]   2> 59771 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1\data,
 hostContext=/solr, hostPort=50441}
   [junit4]   2> 59772 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 59772 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 59772 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 59772 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:12.799Z
   [junit4]   2> 59773 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\solr.xml
   [junit4]   2> 59822 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 59830 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.
   [junit4]   2> 59833 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 59894 INFO  (coreLoadExecutor-50-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 59920 INFO  (coreLoadExecutor-50-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 59935 INFO  (coreLoadExecutor-50-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 59950 INFO  (coreLoadExecutor-50-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1
   [junit4]   2> 59950 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1\data\]
   [junit4]   2> 59951 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 59970 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 59970 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 59970 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 59972 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@fa5f49[collection1] main]
   [junit4]   2> 59973 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1\conf
   [junit4]   2> 59974 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml,xslt/dummy.xsl
   [junit4]   2> 59974 INFO  (coreLoadExecutor-50-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 59974 INFO  
(searcherExecutor-51-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@fa5f49[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 60337 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1
   [junit4]   2> 60352 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 60354 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@10b15a4{/solr,null,AVAILABLE}
   [junit4]   2> 60356 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@d692ad{HTTP/1.1,[http/1.1]}{127.0.0.1:50444}
   [junit4]   2> 60356 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @64307ms
   [junit4]   2> 60356 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1\data,
 hostContext=/solr, hostPort=50444}
   [junit4]   2> 60357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 60357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 60357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 60357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:13.384Z
   [junit4]   2> 60358 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\solr.xml
   [junit4]   2> 60370 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 60377 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.
   [junit4]   2> 60377 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 60399 INFO  (coreLoadExecutor-60-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 60415 INFO  (coreLoadExecutor-60-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 60418 INFO  (coreLoadExecutor-60-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 60421 INFO  (coreLoadExecutor-60-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.\collection1
   [junit4]   2> 60421 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.\collection1\data\]
   [junit4]   2> 60422 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 60435 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 60436 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 60436 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 60437 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@143691[collection1] main]
   [junit4]   2> 60437 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1\conf
   [junit4]   2> 60461 INFO  (coreLoadExecutor-60-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 60461 INFO  
(searcherExecutor-61-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@143691[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 60467 INFO  (qtp4393105-143) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=1
   [junit4]   2> 60467 INFO  (indexFetcher-65-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 60469 INFO  (indexFetcher-65-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 60469 INFO  (indexFetcher-65-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 60881 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@d692ad{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 60881 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30886875
   [junit4]   2> 60882 INFO  (coreCloseExecutor-66-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@14fef8
   [junit4]   2> 60887 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@10b15a4{/solr,null,UNAVAILABLE}
   [junit4]   2> 60892 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@166af30{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 60892 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14847474
   [junit4]   2> 60893 INFO  (coreCloseExecutor-68-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@54426
   [junit4]   2> 60896 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5b59b{/solr,null,UNAVAILABLE}
   [junit4]   2> 60901 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 60902 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@cf7cc0{/solr,null,AVAILABLE}
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@cf7143{HTTP/1.1,[http/1.1]}{127.0.0.1:50460}
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @64854ms
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1\data,
 hostContext=/solr, hostPort=50460}
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:13.931Z
   [junit4]   2> 60904 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\solr.xml
   [junit4]   2> 60925 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 60930 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.
   [junit4]   2> 60930 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 60959 INFO  (coreLoadExecutor-75-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 60975 INFO  (coreLoadExecutor-75-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 60984 INFO  (coreLoadExecutor-75-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 60992 INFO  (coreLoadExecutor-75-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1
   [junit4]   2> 60993 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1\data\]
   [junit4]   2> 60995 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 61016 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 61016 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 61016 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 61017 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1c3f98a[collection1] main]
   [junit4]   2> 61018 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1\conf
   [junit4]   2> 61018 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml
   [junit4]   2> 61018 INFO  (coreLoadExecutor-75-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 61018 INFO  
(searcherExecutor-76-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1c3f98a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 61437 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 61438 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 1
   [junit4]   2> 61440 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 61441 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1bfdeb4
   [junit4]   2> 61443 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@453c48[collection1] main]
   [junit4]   2> 61443 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 61443 INFO  
(searcherExecutor-76-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@453c48[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 61444 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 61450 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=5
   [junit4]   2> 61452 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 61456 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 61457 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@12b39ee{/solr,null,AVAILABLE}
   [junit4]   2> 61458 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@18d374{HTTP/1.1,[http/1.1]}{127.0.0.1:50464}
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @65409ms
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1\data,
 hostContext=/solr, hostPort=50464}
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 61459 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:14.486Z
   [junit4]   2> 61460 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\solr.xml
   [junit4]   2> 61468 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 61473 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.
   [junit4]   2> 61473 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 61494 INFO  (coreLoadExecutor-85-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 61509 INFO  (coreLoadExecutor-85-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 61511 INFO  (coreLoadExecutor-85-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 61514 INFO  (coreLoadExecutor-85-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.\collection1
   [junit4]   2> 61514 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\.\collection1\data\]
   [junit4]   2> 61516 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 61548 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 61548 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 61548 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 61548 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@cb3e99[collection1] main]
   [junit4]   2> 61549 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-002\collection1\conf
   [junit4]   2> 61551 INFO  (coreLoadExecutor-85-thread-1) [    x:collection1] 
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 61551 INFO  
(searcherExecutor-86-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@cb3e99[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 61554 INFO  (qtp5459117-182) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 61555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 61555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1475665394468
   [junit4]   2> 61555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 61555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 61561 INFO  (qtp5459117-183) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=5
   [junit4]   2> 61562 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 1
   [junit4]   2> 61565 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=33, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1114010616543232]
   [junit4]   2> 61566 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 61566 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@1be891e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@88564e)
   [junit4]   2> 61597 INFO  (qtp5459117-176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=9
   [junit4]   2> 61608 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=100) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@1be891e 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@88564e)
   [junit4]   2> 61612 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=842474407, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 61617 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 61617 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@26c718[collection1] main]
   [junit4]   2> 61625 INFO  
(searcherExecutor-86-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@26c718[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 61990 INFO  (qtp8716294-196) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=1
   [junit4]   2> 61991 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 62007 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 62011 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} 
status=0 QTime=0
   [junit4]   2> 62080 INFO  (qtp5459117-180) [    ] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 6.3.0
   [junit4]   2> 62114 INFO  (qtp5459117-180) [    ] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 62123 INFO  (qtp5459117-180) [    ] o.a.s.s.IndexSchema Loaded 
schema test/1.2 with uniqueid field id
   [junit4]   2> 62140 INFO  (qtp5459117-180) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'collection1' using configuration from instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1
   [junit4]   2> 62140 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\.\collection1\data\]
   [junit4]   2> 62166 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 62166 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 62169 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ba9d15[collection1] main]
   [junit4]   2> 62170 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-001\collection1\conf
   [junit4]   2> 62170 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml
   [junit4]   2> 62170 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 62171 INFO  
(searcherExecutor-92-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1ba9d15[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 62171 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=21, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=21.80859375, 
floorSegmentMB=1.7236328125, forceMergeDeletesPctAllowed=28.800694792847317, 
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3971587907731665
   [junit4]   2> 62173 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 62174 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@28e2a3[collection1] main]
   [junit4]   2> 62174 INFO  
(searcherExecutor-92-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@28e2a3[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 62175 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1b7dcbf
   [junit4]   2> 62178 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={core=collection1&qt=/admin/cores&action=reload&wt=javabin&version=2} 
status=0 QTime=149
   [junit4]   2> 62183 INFO  (qtp5459117-182) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 62186 INFO  (qtp5459117-176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} 
status=0 QTime=0
   [junit4]   2> 62192 INFO  (qtp5459117-176) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 2
   [junit4]   2> 62196 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 62200 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 62200 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1fa57a9
   [junit4]   2> 62233 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@197a84e[collection1] main]
   [junit4]   2> 62233 INFO  
(searcherExecutor-92-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@197a84e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c2)))}
   [junit4]   2> 62233 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 62233 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 33
   [junit4]   2> 62279 INFO  (qtp5459117-181) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=42
   [junit4]   2> 62280 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
   [junit4]   2> 62284 INFO  (qtp8716294-197) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 62285 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 62393 INFO  (qtp8716294-198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 62394 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 62496 INFO  (qtp8716294-198) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 62496 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 62554 INFO  (qtp5459117-183) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 62555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 62555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1475665395227
   [junit4]   2> 62555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 62555 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 62560 INFO  (qtp5459117-182) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=4
   [junit4]   2> 62562 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 62564 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=43, maxMergeAtOnceExplicit=50, maxMergedSegmentMB=82.0185546875, 
floorSegmentMB=0.8720703125, forceMergeDeletesPctAllowed=15.184240985305134, 
segmentsPerTier=46.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 62564 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 62565 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@c4d35f 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@694273)
   [junit4]   2> 62571 INFO  (qtp5459117-179) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 62576 INFO  (qtp5459117-176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 62580 INFO  (qtp5459117-177) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 62584 INFO  (qtp5459117-180) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 62585 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=2041) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@c4d35f 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@694273)
   [junit4]   2> 62589 WARN  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Exception while updating statistics
   [junit4]   2> java.io.IOException: file "replication.properties" was already 
written to
   [junit4]   2>        at 
org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:683)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:495)
   [junit4]   2>        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:254)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
   [junit4]   2>        at 
org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$2(ReplicationHandler.java:1147)
   [junit4]   2>        at 
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
   [junit4]   2>        at 
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:745)
   [junit4]   2> 62590 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=40, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3135508579049067]
   [junit4]   2> 62591 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 62598 INFO  (indexFetcher-90-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@293e51[collection1] main]
   [junit4]   2> 62615 INFO  
(searcherExecutor-86-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@293e51[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c2)))}
   [junit4]   2> 62617 INFO  (qtp8716294-200) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 62618 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waited for 300ms and found 2 docs
   [junit4]   2> 62618 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
   [junit4]   2> 62619 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@cf7143{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 62619 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=15286620
   [junit4]   2> 62620 INFO  (coreCloseExecutor-97-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@10c0880
   [junit4]   2> 62623 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@cf7cc0{/solr,null,UNAVAILABLE}
   [junit4]   2> 62627 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@18d374{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 62627 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=8133797
   [junit4]   2> 62628 INFO  (coreCloseExecutor-99-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@f32442
   [junit4]   2> 62633 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@12b39ee{/solr,null,UNAVAILABLE}
   [junit4]   2> 62639 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterWrite2Slave
   [junit4]   2> 62641 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\collection1
   [junit4]   2> 62655 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 62656 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@693df6{/solr,null,AVAILABLE}
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@189e935{HTTP/1.1,[http/1.1]}{127.0.0.1:50470}
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @66609ms
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\collection1\data,
 hostContext=/solr, hostPort=50470}
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 62658 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:15.685Z
   [junit4]   2> 62660 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\solr.xml
   [junit4]   2> 62680 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 62689 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\.
   [junit4]   2> 62689 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 62746 INFO  (coreLoadExecutor-106-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 62766 INFO  (coreLoadExecutor-106-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 62772 INFO  (coreLoadExecutor-106-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 62783 INFO  (coreLoadExecutor-106-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\.\collection1
   [junit4]   2> 62784 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\.\collection1\data\]
   [junit4]   2> 62785 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 62805 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 62805 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 62805 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 62806 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@253b22[collection1] 
main]
   [junit4]   2> 62806 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-003\collection1\conf
   [junit4]   2> 62807 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 62807 INFO  (coreLoadExecutor-106-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 62807 INFO  
(searcherExecutor-107-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@253b22[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 63193 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\collection1
   [junit4]   2> 63212 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 63214 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@bdb4c1{/solr,null,AVAILABLE}
   [junit4]   2> 63217 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@1aaa7d{HTTP/1.1,[http/1.1]}{127.0.0.1:50485}
   [junit4]   2> 63217 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.Server Started @67168ms
   [junit4]   2> 63218 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\collection1\data,
 hostContext=/solr, hostPort=50485}
   [junit4]   2> 63218 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.3.0
   [junit4]   2> 63218 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 63218 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 63218 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2016-10-05T11:03:16.245Z
   [junit4]   2> 63220 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\solr.xml
   [junit4]   2> 63232 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 63245 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\.
   [junit4]   2> 63245 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 63275 INFO  (coreLoadExecutor-116-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.3.0
   [junit4]   2> 63292 INFO  (coreLoadExecutor-116-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 63297 INFO  (coreLoadExecutor-116-thread-1) [    ] 
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 63302 INFO  (coreLoadExecutor-116-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\.\collection1
   [junit4]   2> 63302 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\collection1],
 
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\.\collection1\data\]
   [junit4]   2> 63304 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=23, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4109965621852688]
   [junit4]   2> 63321 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 63321 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 63321 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=32, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7911976019914969]
   [junit4]   2> 63322 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@eed316[collection1] 
main]
   [junit4]   2> 63322 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-004\collection1\conf
   [junit4]   2> 63325 INFO  (coreLoadExecutor-116-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 63326 INFO  
(searcherExecutor-117-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@eed316[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 63759 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=1
   [junit4]   2> 63765 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 3
   [junit4]   2> 63770 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 63774 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 63777 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 63780 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 63785 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 63789 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 63792 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 63796 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 63799 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9]} 0 1
   [junit4]   2> 63802 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 63806 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 63808 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 63809 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 63812 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 63815 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 63819 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 63822 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 63824 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 63830 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 63834 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 63836 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 63841 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 63843 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 63845 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[24]} 0 0
   [junit4]   2> 63848 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 63855 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 63858 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 63864 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 63868 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 63871 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 63875 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 63882 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[32]} 0 1
   [junit4]   2> 63889 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 63892 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 63897 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 63904 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 63910 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 63914 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 63917 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 63920 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 63924 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 63929 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 63932 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[43]} 0 1
   [junit4]   2> 63936 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[44]} 0 0
   [junit4]   2> 63940 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 63943 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 63948 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[47]} 0 0
   [junit4]   2> 63952 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 63955 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 63958 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 63965 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 63969 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 63972 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[53]} 0 0
   [junit4]   2> 63977 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[54]} 0 0
   [junit4]   2> 63983 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[55]} 0 0
   [junit4]   2> 63991 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 63995 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 64000 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 64002 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 64005 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[60]} 0 0
   [junit4]   2> 64007 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 64009 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 64011 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[63]} 0 0
   [junit4]   2> 64015 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[64]} 0 0
   [junit4]   2> 64019 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[65]} 0 0
   [junit4]   2> 64021 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[66]} 0 0
   [junit4]   2> 64022 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[67]} 0 0
   [junit4]   2> 64025 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[68]} 0 0
   [junit4]   2> 64027 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[69]} 0 0
   [junit4]   2> 64033 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[70]} 0 0
   [junit4]   2> 64035 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[71]} 0 0
   [junit4]   2> 64038 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[72]} 0 0
   [junit4]   2> 64060 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[73]} 0 0
   [junit4]   2> 64064 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[74]} 0 0
   [junit4]   2> 64066 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 64067 INFO  (indexFetcher-121-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 64067 INFO  (indexFetcher-121-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 64067 INFO  (indexFetcher-121-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 64067 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[75]} 0 0
   [junit4]   2> 64071 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[76]} 0 0
   [junit4]   2> 64073 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[77]} 0 0
   [junit4]   2> 64077 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[78]} 0 0
   [junit4]   2> 64080 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[79]} 0 0
   [junit4]   2> 64083 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[80]} 0 0
   [junit4]   2> 64087 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[81]} 0 0
   [junit4]   2> 64091 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[82]} 0 0
   [junit4]   2> 64094 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[83]} 0 0
   [junit4]   2> 64097 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[84]} 0 0
   [junit4]   2> 64101 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[85]} 0 0
   [junit4]   2> 64106 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[86]} 0 0
   [junit4]   2> 64110 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[87]} 0 0
   [junit4]   2> 64113 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[88]} 0 0
   [junit4]   2> 64117 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[89]} 0 0
   [junit4]   2> 64119 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[90]} 0 0
   [junit4]   2> 64123 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[91]} 0 0
   [junit4]   2> 64127 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[92]} 0 0
   [junit4]   2> 64131 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[93]} 0 0
   [junit4]   2> 64145 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[94]} 0 0
   [junit4]   2> 64149 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[95]} 0 0
   [junit4]   2> 64153 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[96]} 0 0
   [junit4]   2> 64156 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[97]} 0 0
   [junit4]   2> 64159 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[98]} 0 0
   [junit4]   2> 64163 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[99]} 0 0
   [junit4]   2> 64166 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[100]} 0 0
   [junit4]   2> 64169 INFO  (qtp30201129-222) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[101]} 0 0
   [junit4]   2> 64173 INFO  (qtp30201129-223) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[102]} 0 1
   [junit4]   2> 64176 INFO  (qtp30201129-226) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[103]} 0 0
   [junit4]   2> 64179 INFO  (qtp30201129-224) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[104]} 0 0
   [junit4]   2> 64190 INFO  (qtp30201129-221) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[105]} 0 0
   [junit4]   2> 64207 INFO  (qtp30201129-225) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[106]} 0 13
   [junit4]   2> 64212 INFO  (qtp30201129-219) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[107]} 0 1
   [junit4]   2> 64216 INFO  (qtp30201129-222) [    x:collection1] o.a.s.u.p.Log

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

d-1) [    x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping 
class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=31, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 165096 INFO  (coreLoadExecutor-683-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1d881d[collection1] 
main]
   [junit4]   2> 165097 INFO  (coreLoadExecutor-683-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-030\collection1\conf
   [junit4]   2> 165097 INFO  (coreLoadExecutor-683-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 165097 INFO  
(searcherExecutor-684-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1d881d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 165551 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 165559 INFO  (qtp30221804-1116) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 
QTime=0
   [junit4]   2> 165560 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 165560 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1475665497492
   [junit4]   2> 165560 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 165560 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 165564 INFO  (qtp30221804-1119) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=2
   [junit4]   2> 165564 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 165570 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=21, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=21.80859375, 
floorSegmentMB=1.7236328125, forceMergeDeletesPctAllowed=28.800694792847317, 
segmentsPerTier=24.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3971587907731665
   [junit4]   2> 165571 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 165572 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
NRTCachingDirectory(SimpleFSDirectory@C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-030\collection1\data\index.20161005130458592
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ed413; 
maxCacheMB=48.0 maxMergeSizeMB=4.0)
   [junit4]   2> 165576 INFO  (qtp30221804-1120) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 165580 INFO  (qtp30221804-1120) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 165584 INFO  (qtp30221804-1120) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 171107 INFO  (qtp30221804-1123) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 171108 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=579349) : 5 secs (115869 bytes/sec) to 
NRTCachingDirectory(SimpleFSDirectory@C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001\solr-instance-030\collection1\data\index.20161005130458592
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ed413; 
maxCacheMB=48.0 maxMergeSizeMB=4.0)
   [junit4]   2> 171121 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=31, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 171124 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 171125 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@162164f[collection1] main]
   [junit4]   2> 171126 INFO  
(searcherExecutor-684-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@162164f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.3.0):c92)))}
   [junit4]   2> 171127 INFO  (qtp30066600-1134) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:51100/solr/collection1/replication&command=fetchindex}
 status=0 QTime=5576
   [junit4]   2> 171134 INFO  (qtp30066600-1138) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=92 status=0 QTime=2
   [junit4]   2> 171136 INFO  (qtp30221804-1118) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[92]} 0 3
   [junit4]   2> 171137 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 92 docs
   [junit4]   2> 171138 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.h.TestReplicationHandler approximateTimeInSeconds = 0.0 
timeTakenInSeconds = 5
   [junit4]   2> 171138 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testRateLimitedReplication
   [junit4]   2> 171139 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@17ca860{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 171139 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=32238935
   [junit4]   2> 171140 INFO  (coreCloseExecutor-689-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@8092a3
   [junit4]   2> 171159 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1b26a7d{/solr,null,UNAVAILABLE}
   [junit4]   2> 171162 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@15b842f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 171162 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=17005777
   [junit4]   2> 171163 INFO  (coreCloseExecutor-691-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@573e74
   [junit4]   2> 171166 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[8A116F9B1EED16C1])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@db8ce8{/solr,null,UNAVAILABLE}
   [junit4]   2> 171171 INFO  
(SUITE-TestReplicationHandler-seed#[8A116F9B1EED16C1]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
C:\Users\jenkins\workspace\Lucene-Solr-6.x-Windows\solr\build\solr-core\test\J0\temp\solr.handler.TestReplicationHandler_8A116F9B1EED16C1-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{name=PostingsFormat(name=LuceneVarGapFixedInterval), 
id=PostingsFormat(name=LuceneVarGapFixedInterval), 
newname=PostingsFormat(name=LuceneVarGapFixedInterval)}, docValues:{}, 
maxPointsInLeafNode=1756, maxMBSortInHeap=6.110058469847468, 
sim=ClassicSimilarity, locale=cs, timezone=Europe/Vienna
   [junit4]   2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102 
(32-bit)/cpus=3,threads=1,free=105064832,total=311427072
   [junit4]   2> NOTE: All tests run in this JVM: 
[DistribDocExpirationUpdateProcessorTest, FacetPivotSmallTest, 
TestReplicationHandler]
   [junit4] Completed [13/637 (1!)] on J0 in 111.53s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 54674 lines...]

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

Reply via email to