Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3752/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC

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([15EC0DD12F509D01:E29FE389E9B832E7]: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:1334)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11112 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/init-core-data-001
   [junit4]   2> 448049 INFO  
(SUITE-TestReplicationHandler-seed#[15EC0DD12F509D01]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None) w/ MAC_OS_X supressed 
clientAuth
   [junit4]   2> 448051 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
   [junit4]   2> 448052 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1
   [junit4]   2> 448060 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 448063 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@44393df3{/solr,null,AVAILABLE}
   [junit4]   2> 448066 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@57ed4023{HTTP/1.1,[http/1.1]}{127.0.0.1:63612}
   [junit4]   2> 448066 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server Started @453575ms
   [junit4]   2> 448067 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=63612}
   [junit4]   2> 448067 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 448067 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.0.0
   [junit4]   2> 448067 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 448067 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 448067 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:25.692Z
   [junit4]   2> 448068 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/solr.xml
   [junit4]   2> 448093 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/.
   [junit4]   2> 448093 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 448107 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 448114 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 448117 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 448121 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1
   [junit4]   2> 448121 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 448122 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 448149 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 448149 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 448149 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 448149 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@40794b5f[collection1] main]
   [junit4]   2> 448150 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1/conf
   [junit4]   2> 448150 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 448150 INFO  (coreLoadExecutor-2033-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 448151 INFO  
(searcherExecutor-2034-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@40794b5f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 448631 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1
   [junit4]   2> 448639 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 448642 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@152b596b{/solr,null,AVAILABLE}
   [junit4]   2> 448642 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@189b5354{HTTP/1.1,[http/1.1]}{127.0.0.1:63613}
   [junit4]   2> 448642 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server Started @454151ms
   [junit4]   2> 448642 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=63613}
   [junit4]   2> 448643 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 448643 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.0.0
   [junit4]   2> 448644 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 448644 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 448644 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:26.269Z
   [junit4]   2> 448644 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/solr.xml
   [junit4]   2> 448663 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/.
   [junit4]   2> 448663 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 448672 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 448681 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 448683 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 448685 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/./collection1
   [junit4]   2> 448685 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 448686 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 448696 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 448696 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 448696 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 448696 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@16406585[collection1] main]
   [junit4]   2> 448696 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1/conf
   [junit4]   2> 448699 INFO  (coreLoadExecutor-2043-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 448699 INFO  
(searcherExecutor-2044-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@16406585[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 448702 INFO  (qtp1844275366-4087) [    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> 448703 INFO  (indexFetcher-2048-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 448703 INFO  (indexFetcher-2048-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 448703 INFO  (indexFetcher-2048-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 449193 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@189b5354{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 449193 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1852860343
   [junit4]   2> 449194 INFO  (coreCloseExecutor-2049-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@10eaeaac
   [junit4]   2> 449195 INFO  (coreCloseExecutor-2049-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 449196 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 449196 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@152b596b{/solr,null,UNAVAILABLE}
   [junit4]   2> 449199 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@57ed4023{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 449199 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1990063246
   [junit4]   2> 449200 INFO  (coreCloseExecutor-2051-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@3fe20ae4
   [junit4]   2> 449202 INFO  (coreCloseExecutor-2051-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 449203 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 449203 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@44393df3{/solr,null,UNAVAILABLE}
   [junit4]   2> 449205 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 449207 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@234ace38{/solr,null,AVAILABLE}
   [junit4]   2> 449207 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@6ac8247{HTTP/1.1,[http/1.1]}{127.0.0.1:63615}
   [junit4]   2> 449207 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server Started @454716ms
   [junit4]   2> 449207 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=63615}
   [junit4]   2> 449207 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 449208 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.0.0
   [junit4]   2> 449208 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 449208 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 449208 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:26.833Z
   [junit4]   2> 449208 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/solr.xml
   [junit4]   2> 449217 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/.
   [junit4]   2> 449217 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 449234 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 449244 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 449247 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 449248 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1
   [junit4]   2> 449248 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 449249 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 449259 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 449259 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 449259 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 449260 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7dab0bb2[collection1] main]
   [junit4]   2> 449260 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1/conf
   [junit4]   2> 449260 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml
   [junit4]   2> 449260 INFO  (coreLoadExecutor-2058-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 449260 INFO  
(searcherExecutor-2059-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7dab0bb2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 449755 INFO  (qtp1421528424-4127) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 449756 INFO  (qtp1421528424-4127) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 1
   [junit4]   2> 449757 INFO  (qtp1421528424-4128) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 449757 INFO  (qtp1421528424-4128) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@3468e2a5
   [junit4]   2> 449759 INFO  (qtp1421528424-4128) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7b920063[collection1] main]
   [junit4]   2> 449759 INFO  (qtp1421528424-4128) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 449759 INFO  
(searcherExecutor-2059-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7b920063[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 449759 INFO  (qtp1421528424-4128) [    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 2
   [junit4]   2> 449761 INFO  (qtp1421528424-4129) [    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> 449762 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 449765 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 449767 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@58171a48{/solr,null,AVAILABLE}
   [junit4]   2> 449767 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@4c2261a7{HTTP/1.1,[http/1.1]}{127.0.0.1:63617}
   [junit4]   2> 449767 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.Server Started @455276ms
   [junit4]   2> 449767 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=63617}
   [junit4]   2> 449768 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 449768 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 7.0.0
   [junit4]   2> 449768 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 449769 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 449769 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:27.394Z
   [junit4]   2> 449769 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/solr.xml
   [junit4]   2> 449791 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/.
   [junit4]   2> 449791 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 449798 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 449818 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 449820 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 449820 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/./collection1
   [junit4]   2> 449821 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 449827 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 449839 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 449839 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 449839 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 449839 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@17517c04[collection1] main]
   [junit4]   2> 449840 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-002/collection1/conf
   [junit4]   2> 449841 INFO  (coreLoadExecutor-2068-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 449841 INFO  
(searcherExecutor-2069-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@17517c04[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 450346 INFO  (qtp738968271-4145) [    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> 450347 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 450348 INFO  (qtp1421528424-4130) [    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> 450348 INFO  (qtp1421528424-4131) [    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> 450359 INFO  (qtp1421528424-4125) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 450366 INFO  (qtp1421528424-4125) [    ] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 450380 INFO  (qtp1421528424-4125) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 450382 INFO  (qtp1421528424-4125) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'collection1' using configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1
   [junit4]   2> 450382 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 450392 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 450392 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 450392 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@3b6fafe6[collection1] main]
   [junit4]   2> 450393 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-001/collection1/conf
   [junit4]   2> 450393 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml
   [junit4]   2> 450393 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 450393 INFO  
(searcherExecutor-2074-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3b6fafe6[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 450394 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.40671851209886434]
   [junit4]   2> 450394 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 450394 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@5e952ffa[collection1] main]
   [junit4]   2> 450394 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@73291689
   [junit4]   2> 450394 INFO  
(searcherExecutor-2074-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@5e952ffa[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 450395 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 450395 INFO  (qtp1421528424-4125) [    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=43
   [junit4]   2> 450396 INFO  (qtp1421528424-4127) [    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> 450397 INFO  (qtp1421528424-4129) [    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> 450399 INFO  (qtp1421528424-4130) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 1
   [junit4]   2> 450400 INFO  (qtp1421528424-4131) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 450401 INFO  (qtp1421528424-4132) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 450401 INFO  (qtp1421528424-4132) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1eaed8c
   [junit4]   2> 450404 INFO  (qtp1421528424-4132) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@b3cfcaf[collection1] main]
   [junit4]   2> 450404 INFO  (qtp1421528424-4132) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 450404 INFO  
(searcherExecutor-2074-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@b3cfcaf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C2)))}
   [junit4]   2> 450404 INFO  (qtp1421528424-4132) [    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> 450406 INFO  (qtp1421528424-4125) [    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> 450406 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
   [junit4]   2> 450407 INFO  (qtp738968271-4146) [    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> 450407 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 450433 INFO  (qtp1421528424-4127) [    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> 450433 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 450434 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1483434028026
   [junit4]   2> 450434 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 450434 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 450440 INFO  (qtp1421528424-4129) [    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=5
   [junit4]   2> 450440 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 450441 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=45, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.28506217053065114]
   [junit4]   2> 450442 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 450442 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@40d17a2a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@fec0580)
   [junit4]   2> 450442 INFO  (qtp1421528424-4130) [    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> 450444 INFO  (qtp1421528424-4131) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.tiv&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450446 INFO  (qtp1421528424-4132) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450447 INFO  (qtp1421528424-4125) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.tib&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450448 INFO  (qtp1421528424-4128) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450450 INFO  (qtp1421528424-4127) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450451 INFO  (qtp1421528424-4129) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450452 INFO  (qtp1421528424-4130) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450453 INFO  (qtp1421528424-4131) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 450454 INFO  (qtp1421528424-4132) [    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> 450455 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1852) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@40d17a2a 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@fec0580)
   [junit4]   2> 450456 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 450459 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 450459 INFO  (indexFetcher-2073-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@7bba3c66[collection1] main]
   [junit4]   2> 450460 INFO  
(searcherExecutor-2069-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@7bba3c66[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C2)))}
   [junit4]   2> 450519 INFO  (qtp738968271-4147) [    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> 450519 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.h.TestReplicationHandler Waited for 100ms and found 2 docs
   [junit4]   2> 450519 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
   [junit4]   2> 450520 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@6ac8247{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 450520 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=986884226
   [junit4]   2> 450522 INFO  (coreCloseExecutor-2079-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@7bcdcb7a
   [junit4]   2> 450523 INFO  (coreCloseExecutor-2079-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 450524 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 450524 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@234ace38{/solr,null,UNAVAILABLE}
   [junit4]   2> 450526 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@4c2261a7{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 450527 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1501483293
   [junit4]   2> 450527 INFO  (coreCloseExecutor-2081-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1e6758d5
   [junit4]   2> 450530 INFO  (coreCloseExecutor-2081-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 450530 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 450530 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@58171a48{/solr,null,UNAVAILABLE}
   [junit4]   2> 450533 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
   [junit4]   2> 450534 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/collection1
   [junit4]   2> 450540 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 450543 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@55d4ac54{/solr,null,AVAILABLE}
   [junit4]   2> 450543 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6a992e66{HTTP/1.1,[http/1.1]}{127.0.0.1:63621}
   [junit4]   2> 450543 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.Server Started @456052ms
   [junit4]   2> 450543 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/collection1/data,
 hostContext=/solr, hostPort=63621}
   [junit4]   2> 450544 ERROR 
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 450544 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 450544 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 450544 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 450544 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:28.169Z
   [junit4]   2> 450545 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/solr.xml
   [junit4]   2> 450562 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/.
   [junit4]   2> 450562 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 450577 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 450594 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 450597 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 450601 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/./collection1
   [junit4]   2> 450602 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 450603 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 450617 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 450617 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 450618 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 450618 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@74f85127[collection1] main]
   [junit4]   2> 450618 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-003/collection1/conf
   [junit4]   2> 450619 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 450619 INFO  (coreLoadExecutor-2088-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 450619 INFO  
(searcherExecutor-2089-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@74f85127[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 451105 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/collection1
   [junit4]   2> 451110 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 451112 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5ded0833{/solr,null,AVAILABLE}
   [junit4]   2> 451112 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@7cc72b08{HTTP/1.1,[http/1.1]}{127.0.0.1:63622}
   [junit4]   2> 451112 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.e.j.s.Server Started @456621ms
   [junit4]   2> 451112 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/collection1/data,
 hostContext=/solr, hostPort=63622}
   [junit4]   2> 451112 ERROR 
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 451113 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 
7.0.0
   [junit4]   2> 451113 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 451113 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 451113 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-03T09:00:28.738Z
   [junit4]   2> 451114 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/solr.xml
   [junit4]   2> 451154 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/.
   [junit4]   2> 451154 INFO  
(TEST-TestReplicationHandler.doTestDetails-seed#[15EC0DD12F509D01]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 451165 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 451186 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 451188 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 451190 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/./collection1
   [junit4]   2> 451190 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/./collection1/data/]
   [junit4]   2> 451191 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 451206 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 451206 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 451206 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 451206 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@39a1027e[collection1] main]
   [junit4]   2> 451207 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-004/collection1/conf
   [junit4]   2> 451208 INFO  (coreLoadExecutor-2098-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 451209 INFO  
(searcherExecutor-2099-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@39a1027e[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 451213 INFO  (qtp912915041-4171) [    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> 451213 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 451214 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 451214 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 451695 INFO  (qtp912915041-4173) [    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> 451696 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 451700 INFO  (qtp912915041-4175) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 451701 INFO  (qtp1646682622-4188) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=1
   [junit4]   2> 451703 INFO  (qtp912915041-4176) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 451703 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 451704 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6593ac4a
   [junit4]   2> 451708 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@c9d417f[collection1] main]
   [junit4]   2> 451708 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 451708 INFO  
(searcherExecutor-2089-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@c9d417f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 451708 INFO  (qtp912915041-4169) [    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 4
   [junit4]   2> 452210 INFO  (qtp912915041-4171) [    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> 452210 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 452210 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1483434029329
   [junit4]   2> 452211 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 452211 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 452214 INFO  (qtp912915041-4172) [    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=3
   [junit4]   2> 452215 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 452237 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=45, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.28506217053065114]
   [junit4]   2> 452237 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 452238 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@d2e7811 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42b850a1)
   [junit4]   2> 452239 INFO  (qtp912915041-4173) [    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> 452242 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.tiv&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452245 INFO  (qtp912915041-4175) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452246 INFO  (qtp912915041-4176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.tib&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452247 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452249 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452252 INFO  (qtp912915041-4172) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452254 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452255 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0_LuceneVarGapDocFreqInterval_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452257 INFO  (qtp912915041-4175) [    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> 452258 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1818) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@d2e7811 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42b850a1)
   [junit4]   2> 452265 INFO  (qtp1646682622-4190) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:63621/solr/collection1/replication&command=fetchindex}
 status=0 QTime=1
   [junit4]   2> 452281 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 452282 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 452283 INFO  (indexFetcher-2103-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@609b4f6d[collection1] main]
   [junit4]   2> 452283 INFO  
(searcherExecutor-2099-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@609b4f6d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)))}
   [junit4]   2> 452332 INFO  (qtp912915041-4176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 452333 INFO  (qtp1646682622-4191) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=4
   [junit4]   2> 452336 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 1
   [junit4]   2> 452337 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 452337 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6593ac4a
   [junit4]   2> 452342 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1f3b1f94[collection1] main]
   [junit4]   2> 452342 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 452342 INFO  
(searcherExecutor-2089-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1f3b1f94[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 452342 INFO  (qtp912915041-4171) [    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 5
   [junit4]   2> 452344 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 452347 INFO  (qtp912915041-4172) [    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> 452347 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 452347 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1483434029962
   [junit4]   2> 452347 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 452347 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 452375 INFO  (qtp912915041-4172) [    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=27
   [junit4]   2> 452376 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 19
   [junit4]   2> 452379 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=45, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.28506217053065114]
   [junit4]   2> 452380 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 452381 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@1ce1ea71 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75a14dba)
   [junit4]   2> 452381 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 452381 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.tiv 
because it already exists
   [junit4]   2> 452382 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.tib 
because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 452383 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.doc 
because it already exists
   [junit4]   2> 452384 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_LuceneVarGapDocFreqInterval_0.tib&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452387 INFO  (qtp912915041-4175) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452388 INFO  (qtp912915041-4176) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452390 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_LuceneVarGapDocFreqInterval_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452396 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452397 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452399 INFO  (qtp912915041-4172) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452400 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1_LuceneVarGapDocFreqInterval_0.tiv&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452402 INFO  (qtp912915041-4174) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 452414 INFO  (qtp912915041-4176) [    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> 452414 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1881) : 0 secs (null bytes/sec) to 
MockDirectoryWrapper(RAMDirectory@1ce1ea71 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@75a14dba)
   [junit4]   2> 452423 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=29, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 452460 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 452461 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@e3ccca[collection1] main]
   [junit4]   2> 452462 INFO  
(searcherExecutor-2099-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@e3ccca[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1)))}
   [junit4]   2> 452462 INFO  (qtp1646682622-4192) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:63621/solr/collection1/replication&command=fetchindex}
 status=0 QTime=118
   [junit4]   2> 452465 INFO  (qtp912915041-4169) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={slave=false&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=0
   [junit4]   2> 452466 INFO  (qtp1646682622-4193) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} 
status=0 QTime=2
   [junit4]   2> 452467 INFO  (qtp912915041-4171) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 452468 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 452468 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@6593ac4a
   [junit4]   2> 452474 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@19c91fc0[collection1] main]
   [junit4]   2> 452474 INFO  (qtp912915041-4173) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 452474 INFO  
(searcherExecutor-2089-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@19c91fc0[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C1)
 Uninverting(_1(7.0.0):C1) Uninverting(_2(7.0.0):C1)))}
   [junit4]   2> 452474 INFO  (qtp912915041-4173) [    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 6
   [junit4]   2> 452476 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 452481 INFO  (qtp912915041-4172) [    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> 452481 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 4
   [junit4]   2> 452481 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1483434030093
   [junit4]   2> 452481 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 3
   [junit4]   2> 452481 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 452483 INFO  (qtp912915041-4175) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=1
   [junit4]   2> 452483 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 28
   [junit4]   2> 452495 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=45, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.28506217053065114]
   [junit4]   2> 452496 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 452496 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MockDirectoryWrapper(RAMDirectory@5848579c 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@2c98ac2c)
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.tiv 
because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.tib 
because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Skipping download for _0_LuceneVarGapDocFreqInterval_0.doc 
because it already exists
   [junit4]   2> 452497 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s

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

oadExecutor-2685-thread-1) [    x:collection1] o.a.s.s.IndexSchema Loaded 
schema test/1.2 with uniqueid field id
   [junit4]   2> 569473 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-030/./collection1
   [junit4]   2> 569473 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-030/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-030/./collection1/data/]
   [junit4]   2> 569475 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=16, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=88.208984375, 
floorSegmentMB=0.5615234375, forceMergeDeletesPctAllowed=26.77444263361279, 
segmentsPerTier=11.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 569487 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 569487 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 569487 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 569488 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2092b7f1[collection1] main]
   [junit4]   2> 569488 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001/solr-instance-030/collection1/conf
   [junit4]   2> 569489 INFO  (coreLoadExecutor-2685-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 569490 INFO  
(searcherExecutor-2686-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@2092b7f1[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 569978 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestHandlerPathUnchanged
   [junit4]   2> 569979 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@59c27450{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 569979 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1425037163
   [junit4]   2> 569980 INFO  (coreCloseExecutor-2691-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@32f7a532
   [junit4]   2> 569982 INFO  (coreCloseExecutor-2691-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 569982 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 569983 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@277e1718{/solr,null,UNAVAILABLE}
   [junit4]   2> 569984 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@25043b35{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 569984 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=674722948
   [junit4]   2> 569985 INFO  (coreCloseExecutor-2693-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@4d2f1c31
   [junit4]   2> 569986 INFO  (coreCloseExecutor-2693-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 569987 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 569987 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[15EC0DD12F509D01])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7124e84c{/solr,null,UNAVAILABLE}
   [junit4]   2> 569989 INFO  
(SUITE-TestReplicationHandler-seed#[15EC0DD12F509D01]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_15EC0DD12F509D01-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{name=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
id=PostingsFormat(name=LuceneVarGapDocFreqInterval), 
newname=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{}, 
maxPointsInLeafNode=757, maxMBSortInHeap=5.693983139489942, 
sim=RandomSimilarity(queryNorm=false): {}, locale=sq-AL, 
timezone=Atlantic/Reykjavik
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_102 
(64-bit)/cpus=3,threads=1,free=55840696,total=217530368
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestCopyFieldCollectionResource, TestBulkSchemaAPI, MBeansHandlerTest, 
TestHighlightDedupGrouping, PeerSyncTest, BitVectorTest, 
TestStressCloudBlindAtomicUpdates, DocumentAnalysisRequestHandlerTest, 
CollectionStateFormat2Test, DistributedQueryElevationComponentTest, 
TestSha256AuthenticationProvider, TestGeoJSONResponseWriter, 
DirectSolrConnectionTest, IndexBasedSpellCheckerTest, TestJmxIntegration, 
TestCustomStream, DistributedFacetExistsSmallTest, 
TestSolrCloudWithKerberosAlt, SpatialRPTFieldTypeTest, TestSolr4Spatial2, 
QueryElevationComponentTest, TestFastOutputStream, IndexSchemaRuntimeFieldTest, 
TestSweetSpotSimilarityFactory, FastVectorHighlighterTest, 
TestSolrQueryParserResource, TestSQLHandler, TestPKIAuthenticationPlugin, 
DocExpirationUpdateProcessorFactoryTest, TestSlowCompositeReaderWrapper, 
VMParamsZkACLAndCredentialsProvidersTest, TestSurroundQueryParser, 
ClassificationUpdateProcessorFactoryTest, TestPerFieldSimilarity, 
TestManagedSchemaThreadSafety, TestFieldCacheSortRandom, 
DeleteLastCustomShardedReplicaTest, TestDynamicFieldCollectionResource, 
SolrRequestParserTest, TestLeaderElectionWithEmptyReplica, FileUtilsTest, 
SharedFSAutoReplicaFailoverUtilsTest, OverseerCollectionConfigSetProcessorTest, 
TestNumericTerms32, SystemInfoHandlerTest, SuggestComponentTest, 
ZkNodePropsTest, SolrMetricsIntegrationTest, SolrMetricManagerTest, 
DistributedSuggestComponentTest, MultiTermTest, 
OutOfBoxZkACLAndCredentialsProvidersTest, TestHdfsUpdateLog, PolyFieldTest, 
DeleteReplicaTest, CustomCollectionTest, TestCloudDeleteByQuery, 
SynonymTokenizerTest, PKIAuthenticationIntegrationTest, ShardRoutingTest, 
TestReplicationHandler]
   [junit4] Completed [155/673 (1!)] on J0 in 121.97s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 57206 lines...]
-ecj-javadoc-lint-src:
    [mkdir] Created dir: 
/var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj1362864111
 [ecj-lint] Compiling 49 source files to 
/var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj1362864111
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: 
/Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. ERROR in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/test-framework/src/java/org/apache/solr/cloud/AbstractDistribZkTestBase.java
 (at line 22)
 [ecj-lint]     import java.util.concurrent.TimeUnit;
 [ecj-lint]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The import java.util.concurrent.TimeUnit is never used
 [ecj-lint] ----------
 [ecj-lint] 1 problem (1 error)

BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:775: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:101: The following 
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build.xml:671: The 
following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1992:
 The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:2031:
 Compile failed; see the compiler error output for details.

Total time: 101 minutes 59 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any


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

Reply via email to