Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/17900/
Java: 64bit/jdk1.8.0_102 -XX:+UseCompressedOops -XX:+UseParallelGC

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

Error Message:
timed out waiting for collection1 startAt time to exceed: Sun Sep 25 20:09:56 
WEST 2016

Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to 
exceed: Sun Sep 25 20:09:56 WEST 2016
        at 
__randomizedtesting.SeedInfo.seed([1AB77B68D36CBF84:C11C7BAED644D637]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at 
org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1508)
        at 
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:858)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
        at java.lang.Thread.run(Thread.java:745)




Build Log:
[...truncated 11895 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/init-core-data-001
   [junit4]   2> 1103635 INFO  
(SUITE-TestReplicationHandler-seed#[1AB77B68D36CBF84]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 1103636 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRateLimitedReplication
   [junit4]   2> 1103636 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1
   [junit4]   2> 1103639 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1103639 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@611b3702{/solr,null,AVAILABLE}
   [junit4]   2> 1103641 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@53efc90b{HTTP/1.1,[http/1.1]}{127.0.0.1:37305}
   [junit4]   2> 1103641 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server Started @1105953ms
   [junit4]   2> 1103641 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=37305}
   [junit4]   2> 1103641 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/solr.xml
   [junit4]   2> 1103658 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/.
   [junit4]   2> 1103658 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1103666 WARN  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1103666 INFO  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1103671 INFO  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1103672 INFO  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1103674 INFO  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] unique key field: id
   [junit4]   2> 1103675 INFO  (coreLoadExecutor-2055-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1
   [junit4]   2> 1103675 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1103675 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1103675 WARN  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1103676 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7161238728907757]
   [junit4]   2> 1103676 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6fc5e1ce 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@412b2293),segFN=segments_1,generation=1}
   [junit4]   2> 1103676 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.PluginBag [collection1] Initialized 26 plugins of type 
requestHandler: [/update, /update/json, /update/csv, /update/json/docs, 
/config, /schema, /replication, /get, /admin/ping, /admin/segments, 
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads, 
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql, 
/terms, standard, defaults, lazy]
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=29, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=1.228515625, 
floorSegmentMB=0.6357421875, forceMergeDeletesPctAllowed=14.792327528886629, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6fc5e1ce 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@412b2293),segFN=segments_1,generation=1}
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@23a2ad98[collection1] main]
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1103680 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1103681 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1103681 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1103681 INFO  (coreLoadExecutor-2055-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1103681 INFO  
(searcherExecutor-2056-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@23a2ad98[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1104164 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1
   [junit4]   2> 1104166 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1104167 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@299f6323{/solr,null,AVAILABLE}
   [junit4]   2> 1104167 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@2daf296f{HTTP/1.1,[http/1.1]}{127.0.0.1:32871}
   [junit4]   2> 1104167 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server Started @1106479ms
   [junit4]   2> 1104167 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=32871}
   [junit4]   2> 1104168 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/solr.xml
   [junit4]   2> 1104173 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/.
   [junit4]   2> 1104173 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1104179 WARN  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1104179 INFO  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1104182 INFO  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1104184 INFO  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1104186 INFO  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] unique key field: id
   [junit4]   2> 1104186 INFO  (coreLoadExecutor-2065-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1
   [junit4]   2> 1104187 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1104187 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1104187 WARN  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1104187 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.7161238728907757]
   [junit4]   2> 1104188 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6ffa91b5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30b6362b),segFN=segments_1,generation=1}
   [junit4]   2> 1104188 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.PluginBag [collection1] Initialized 26 plugins of type 
requestHandler: [/update, /update/json, /update/csv, /update/json/docs, 
/config, /schema, /replication, /get, /admin/ping, /admin/segments, 
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads, 
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql, 
/terms, standard, defaults, lazy]
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=29, maxMergeAtOnceExplicit=45, maxMergedSegmentMB=1.228515625, 
floorSegmentMB=0.6357421875, forceMergeDeletesPctAllowed=14.792327528886629, 
segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6ffa91b5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30b6362b),segFN=segments_1,generation=1}
   [junit4]   2> 1104191 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1104192 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3a9481c[collection1] 
main]
   [junit4]   2> 1104192 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf
   [junit4]   2> 1104192 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1104192 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf
   [junit4]   2> 1104192 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1104193 INFO  (coreLoadExecutor-2065-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1104193 INFO  
(searcherExecutor-2066-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3a9481c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1104632 INFO  (qtp1164249905-4050) [    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> 1104632 INFO  (indexFetcher-2070-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1104632 INFO  (indexFetcher-2070-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1104632 INFO  (indexFetcher-2070-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1104679 INFO  (qtp1164249905-4052) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1104680 INFO  (qtp1164249905-4052) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1104680 INFO  (qtp1063512819-4067) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1104681 INFO  (qtp1063512819-4067) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1104682 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1104682 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@738c4d54
   [junit4]   2> 1104682 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6fc5e1ce 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@412b2293),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6fc5e1ce 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@412b2293),segFN=segments_2,generation=2}
   [junit4]   2> 1104682 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1104683 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@254a9e8[collection1] main]
   [junit4]   2> 1104683 INFO  (qtp1164249905-4045) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1104683 INFO  
(searcherExecutor-2056-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@254a9e8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1104683 INFO  (qtp1164249905-4045) [    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 1
   [junit4]   2> 1104683 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1104683 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@58659ca5
   [junit4]   2> 1104684 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6ffa91b5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30b6362b),segFN=segments_1,generation=1}
   [junit4]   2>        commit{dir=MockDirectoryWrapper(RAMDirectory@6ffa91b5 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@30b6362b),segFN=segments_2,generation=2}
   [junit4]   2> 1104684 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1104684 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@179f63e2[collection1] main]
   [junit4]   2> 1104684 INFO  (qtp1063512819-4068) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1104684 INFO  
(searcherExecutor-2066-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@179f63e2[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1104684 INFO  (qtp1063512819-4068) [    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 1
   [junit4]   2> 1104685 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@53efc90b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1104685 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1151820996
   [junit4]   2> 1104685 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@31731bdf
   [junit4]   2> 1104685 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 
directories currently being tracked
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data;done=false>>]
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/snapshot_metadata
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/snapshot_metadata;done=false>>]
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/snapshot_metadata
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index;done=false>>]
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104686 INFO  (coreCloseExecutor-2071-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index
   [junit4]   2> 1104687 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@611b3702{/solr,null,UNAVAILABLE}
   [junit4]   2> 1104687 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@2daf296f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1104687 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2041785440
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1976bdea
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 
directories currently being tracked
   [junit4]   2> 1104688 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/snapshot_metadata
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/snapshot_metadata;done=false>>]
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/snapshot_metadata
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data;done=false>>]
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index;done=false>>]
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1104689 INFO  (coreCloseExecutor-2073-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index
   [junit4]   2> 1104690 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@299f6323{/solr,null,UNAVAILABLE}
   [junit4]   2> 1104693 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1104694 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1fcfd90f{/solr,null,AVAILABLE}
   [junit4]   2> 1104694 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@76a3dbe6{HTTP/1.1,[http/1.1]}{127.0.0.1:41164}
   [junit4]   2> 1104694 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server Started @1107006ms
   [junit4]   2> 1104694 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=41164}
   [junit4]   2> 1104695 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/solr.xml
   [junit4]   2> 1104699 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/.
   [junit4]   2> 1104699 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1104706 WARN  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1104706 INFO  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1104712 INFO  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1104715 INFO  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1104717 INFO  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] unique key field: id
   [junit4]   2> 1104718 INFO  (coreLoadExecutor-2080-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1
   [junit4]   2> 1104724 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1104726 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1104726 WARN  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1104727 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=480104399, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1104756 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7421f293; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 1104756 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1104762 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.PluginBag [collection1] Initialized 26 plugins of type 
requestHandler: [/update, /update/json, /update/csv, /update/json/docs, 
/config, /schema, /replication, /get, /admin/ping, /admin/segments, 
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads, 
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql, 
/terms, standard, defaults, lazy]
   [junit4]   2> 1104763 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1104763 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1104763 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1104763 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=16, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4267055666302757]
   [junit4]   2> 1104763 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7421f293; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@55ba6f17[collection1] main]
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1104764 INFO  (coreLoadExecutor-2080-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1104764 INFO  
(searcherExecutor-2081-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@55ba6f17[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1105204 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 2
   [junit4]   2> 1105206 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 1
   [junit4]   2> 1105207 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1105208 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1105208 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1105209 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 1105210 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 1105210 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 1105210 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 1105211 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 1105211 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 1105212 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 1105212 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 1105213 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 1105213 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 1105216 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 1105216 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 1105217 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 1105218 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 1105219 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 1105219 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1105220 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 1105220 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 1105221 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 1105224 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[24]} 0 0
   [junit4]   2> 1105224 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 1105225 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 1105225 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 1105226 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 1105226 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 1105227 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 1105227 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 1105228 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[32]} 0 0
   [junit4]   2> 1105228 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 1105229 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 1105239 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[35]} 0 9
   [junit4]   2> 1105240 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 1105240 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 1105241 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 1105242 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 1105243 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 1105243 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 1105244 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 1105244 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[43]} 0 0
   [junit4]   2> 1105245 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[44]} 0 0
   [junit4]   2> 1105246 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 1105246 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 1105247 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[47]} 0 0
   [junit4]   2> 1105247 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 1105247 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 1105248 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 1105248 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 1105249 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 1105249 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[53]} 0 0
   [junit4]   2> 1105249 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[54]} 0 0
   [junit4]   2> 1105250 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[55]} 0 0
   [junit4]   2> 1105250 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 1105251 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 1105251 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 1105251 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 1105252 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[60]} 0 0
   [junit4]   2> 1105252 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 1105253 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 1105255 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[63]} 0 0
   [junit4]   2> 1105255 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[64]} 0 0
   [junit4]   2> 1105256 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[65]} 0 0
   [junit4]   2> 1105256 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[66]} 0 0
   [junit4]   2> 1105257 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[67]} 0 0
   [junit4]   2> 1105257 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[68]} 0 0
   [junit4]   2> 1105258 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[69]} 0 0
   [junit4]   2> 1105258 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[70]} 0 0
   [junit4]   2> 1105259 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[71]} 0 0
   [junit4]   2> 1105259 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[72]} 0 0
   [junit4]   2> 1105260 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[73]} 0 0
   [junit4]   2> 1105260 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[74]} 0 0
   [junit4]   2> 1105260 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[75]} 0 0
   [junit4]   2> 1105261 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[76]} 0 0
   [junit4]   2> 1105262 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[77]} 0 0
   [junit4]   2> 1105262 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[78]} 0 0
   [junit4]   2> 1105262 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[79]} 0 0
   [junit4]   2> 1105263 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[80]} 0 0
   [junit4]   2> 1105263 INFO  (qtp371797626-4089) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[81]} 0 0
   [junit4]   2> 1105264 INFO  (qtp371797626-4091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[82]} 0 0
   [junit4]   2> 1105264 INFO  (qtp371797626-4084) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[83]} 0 0
   [junit4]   2> 1105264 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1105264 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5d54b787
   [junit4]   2> 1105402 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=2
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7421f293; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7421f293; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
   [junit4]   2> 1105402 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1105448 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@4936a8b4[collection1] main]
   [junit4]   2> 1105448 INFO  (qtp371797626-4090) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1105448 INFO  
(searcherExecutor-2081-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@4936a8b4[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C84)))}
   [junit4]   2> 1105448 INFO  (qtp371797626-4090) [    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 183
   [junit4]   2> 1105450 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@76a3dbe6{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1105450 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=558113827
   [junit4]   2> 1105450 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@6bd6ff7e
   [junit4]   2> 1105451 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=1,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=84,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1105451 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1105451 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 1105451 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing 
NRTCachingDirectoryFactory - 3 directories currently being tracked
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/snapshot_metadata
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/snapshot_metadata;done=false>>]
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/snapshot_metadata
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index;done=false>>]
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data;done=false>>]
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1105452 INFO  (coreCloseExecutor-2085-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data
   [junit4]   2> 1105453 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1fcfd90f{/solr,null,UNAVAILABLE}
   [junit4]   2> 1105455 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1105456 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@3c6e2ec8{/solr,null,AVAILABLE}
   [junit4]   2> 1105456 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@58b36d7b{HTTP/1.1,[http/1.1]}{127.0.0.1:42830}
   [junit4]   2> 1105456 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server Started @1107768ms
   [junit4]   2> 1105457 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=42830}
   [junit4]   2> 1105458 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/solr.xml
   [junit4]   2> 1105466 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/.
   [junit4]   2> 1105466 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1105473 WARN  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1105474 INFO  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1105479 INFO  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1105482 INFO  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1105484 INFO  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] unique key field: id
   [junit4]   2> 1105485 INFO  (coreLoadExecutor-2092-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1
   [junit4]   2> 1105486 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1105486 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/./collection1/data/index/
   [junit4]   2> 1105491 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.PluginBag [collection1] Initialized 26 plugins of type 
requestHandler: [/update, /update/json, /update/csv, /update/json/docs, 
/config, /schema, /replication, /get, /admin/ping, /admin/segments, 
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads, 
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql, 
/terms, standard, defaults, lazy]
   [junit4]   2> 1105491 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1105491 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1105491 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1105492 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=480104399, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1105494 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d08032c; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_2,generation=2}
   [junit4]   2> 1105495 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 2
   [junit4]   2> 1105525 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3b0b4243[collection1] main]
   [junit4]   2> 1105526 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1105526 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf}
   [junit4]   2> 1105526 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/conf
   [junit4]   2> 1105526 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1105526 INFO  (coreLoadExecutor-2092-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1105526 INFO  
(searcherExecutor-2093-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3b0b4243[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C84)))}
   [junit4]   2> 1105970 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server jetty-9.3.8.v20160314
   [junit4]   2> 1105971 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@665bcba4{/solr,null,AVAILABLE}
   [junit4]   2> 1105971 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Started 
ServerConnector@e06245e{HTTP/1.1,[http/1.1]}{127.0.0.1:40275}
   [junit4]   2> 1105971 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.Server Started @1108283ms
   [junit4]   2> 1105971 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=40275}
   [junit4]   2> 1105972 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/solr.xml
   [junit4]   2> 1105978 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/.
   [junit4]   2> 1105978 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1105982 WARN  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use 
<mergePolicyFactory> instead.
   [junit4]   2> 1105983 INFO  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1105987 INFO  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
   [junit4]   2> 1105989 INFO  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1105990 INFO  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.s.IndexSchema [collection1] unique key field: id
   [junit4]   2> 1105991 INFO  (coreLoadExecutor-2102-thread-1) [    ] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from 
instancedir 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1
   [junit4]   2> 1105991 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1105991 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null 
new=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index/
   [junit4]   2> 1105991 WARN  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory 
'/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/./collection1/data/index'
 doesn't exist. Creating new index...
   [junit4]   2> 1105992 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=480104399, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1106001 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@554ae2fa; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 1106001 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1106004 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.PluginBag [collection1] Initialized 26 plugins of type 
requestHandler: [/update, /update/json, /update/csv, /update/json/docs, 
/config, /schema, /replication, /get, /admin/ping, /admin/segments, 
/admin/luke, /admin/system, /admin/mbeans, /admin/plugins, /admin/threads, 
/admin/properties, /admin/logging, /admin/file, /export, /graph, /stream, /sql, 
/terms, standard, defaults, lazy]
   [junit4]   2> 1106004 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.RequestHandlers Registered paths: 
/admin/mbeans,standard,lazy,/update/json/docs,/admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/update/csv,/sql,/graph,/admin/segments,/admin/system,/replication,defaults,/config,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin/file,/terms
   [junit4]   2> 1106005 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1106005 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1106005 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=16, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4267055666302757]
   [junit4]   2> 1106005 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: 
num=1
   [junit4]   2>        
commit{dir=NRTCachingDirectory(MMapDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/data/index
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@554ae2fa; 
maxCacheMB=48.0 maxMergeSizeMB=4.0),segFN=segments_1,generation=1}
   [junit4]   2> 1106005 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@27ee761f[collection1] main]
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: 
{storageDir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf}
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using 
file:dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-002/collection1/conf
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
   [junit4]   2> 1106006 INFO  (coreLoadExecutor-2102-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1106006 INFO  
(searcherExecutor-2103-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@27ee761f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1106481 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1106482 INFO  (qtp1659052296-4109) [    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> 1106482 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1106482 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1474830575855
   [junit4]   2> 1106482 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1106482 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1106484 WARN  (qtp1659052296-4108) [    x:collection1] 
o.a.s.h.ReplicationHandler Could not read checksum from index file: _0.si
   [junit4]   2> org.apache.lucene.index.CorruptIndexException: codec footer 
mismatch (file truncated?): actual footer=808464432 vs expected 
footer=-1071082520 
(resource=MMapIndexInput(path="/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-001/collection1/data/index/_0.si"))
   [junit4]  

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

xFetcher.fetchFileList(IndexFetcher.java:244)
   [junit4]   2>        ... 5 more
   [junit4]   2> Caused by: org.apache.http.conn.HttpHostConnectException: 
Connect to 127.0.0.1:35780 [/127.0.0.1] failed: Connection refused
   [junit4]   2>        at 
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:151)
   [junit4]   2>        at 
org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:353)
   [junit4]   2>        at 
org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:380)
   [junit4]   2>        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:236)
   [junit4]   2>        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:184)
   [junit4]   2>        at 
org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:88)
   [junit4]   2>        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:110)
   [junit4]   2>        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:184)
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
   [junit4]   2>        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
   [junit4]   2>        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:513)
   [junit4]   2>        ... 9 more
   [junit4]   2> Caused by: java.net.ConnectException: Connection refused
   [junit4]   2>        at java.net.PlainSocketImpl.socketConnect(Native Method)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206)
   [junit4]   2>        at 
java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188)
   [junit4]   2>        at 
java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392)
   [junit4]   2>        at java.net.Socket.connect(Socket.java:589)
   [junit4]   2>        at 
org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:74)
   [junit4]   2>        at 
org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:134)
   [junit4]   2>        ... 19 more
   [junit4]   2> 
   [junit4]   2> 1186061 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@25010c38{/solr,null,UNAVAILABLE}
   [junit4]   2> 1186062 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.ServerConnector Stopped 
ServerConnector@3b3adb2c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1186062 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[1AB77B68D36CBF84])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=22207570
   [junit4]   2> 1186062 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1bbdfd16
   [junit4]   2> 1186064 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.u.DirectUpdateHandler2 closing 
DirectUpdateHandler2{commits=5,autocommits=0,soft 
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 1186064 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
   [junit4]   2> 1186064 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 
0 - closing IndexWriter
   [junit4]   2> 1186064 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with 
IndexWriterCloser
   [junit4]   2> 1186064 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 3 
directories currently being tracked
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/snapshot_metadata
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/snapshot_metadata;done=false>>]
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/snapshot_metadata
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data;done=false>>]
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/index
 
[CachedDir<<refCount=0;path=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/index;done=false>>]
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory, 
CoreContainer#isShutdown=true
   [junit4]   2> 1186065 INFO  (coreCloseExecutor-2708-thread-1) [    
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001/solr-instance-030/./collection1/data/index
   [junit4]   2> 1186066 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[1AB77B68D36CBF84])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@476e77da{/solr,null,UNAVAILABLE}
   [junit4]   2> 1186067 INFO  
(SUITE-TestReplicationHandler-seed#[1AB77B68D36CBF84]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_1AB77B68D36CBF84-001
   [junit4]   2> NOTE: test params are: codec=SimpleText, 
sim=RandomSimilarity(queryNorm=false): {}, locale=fr-BE, 
timezone=Africa/Casablanca
   [junit4]   2> NOTE: Linux 4.4.0-36-generic amd64/Oracle Corporation 
1.8.0_102 (64-bit)/cpus=12,threads=1,free=295538904,total=517996544
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestManagedStopFilterFactory, TestInitParams, TestFieldTypeResource, 
AsyncCallRequestStatusResponseTest, 
IgnoreCommitOptimizeUpdateProcessorFactoryTest, TriLevelCompositeIdRoutingTest, 
StatsReloadRaceTest, TestConfigSetImmutable, HdfsBasicDistributedZkTest, 
MBeansHandlerTest, TestMaxScoreQueryParser, TestSolrXml, TestSolr4Spatial, 
TestStandardQParsers, RegexBoostProcessorTest, 
DistributedQueryElevationComponentTest, CleanupOldIndexTest, 
TestOverriddenPrefixQueryForCustomFieldType, AlternateDirectoryTest, 
DocValuesMissingTest, DistributedQueryComponentCustomSortTest, 
TestSolrQueryResponse, TestExclusionRuleCollectionAccess, TestBulkSchemaAPI, 
RecoveryAfterSoftCommitTest, TestTolerantUpdateProcessorCloud, 
TestAtomicUpdateErrorCases, FileBasedSpellCheckerTest, CacheHeaderTest, 
TestFastWriter, FacetPivotSmallTest, TestRangeQuery, TestGraphMLResponseWriter, 
CursorPagingTest, TestOmitPositions, HdfsThreadLeakTest, TestBadConfig, 
TestRemoteStreaming, DefaultValueUpdateProcessorTest, TestDefaultStatsCache, 
TestReplicationHandlerBackup, PolyFieldTest, 
TestSolrQueryParserDefaultOperatorResource, SharedFSAutoReplicaFailoverTest, 
CollectionStateFormat2Test, BlockJoinFacetSimpleTest, TestCSVLoader, 
QueryResultKeyTest, HdfsCollectionsAPIDistributedZkTest, 
StandardRequestHandlerTest, TestLeaderInitiatedRecoveryThread, 
TestBulkSchemaConcurrent, InfoHandlerTest, TestExactStatsCache, 
CollectionsAPISolrJTest, RuleEngineTest, TestNamedUpdateProcessors, 
CheckHdfsIndexTest, ZkStateReaderTest, TestSchemaSimilarityResource, 
ActionThrottleTest, TestReplicationHandler]
   [junit4] Completed [435/636 (1!)] on J0 in 82.44s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 60903 lines...]

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

Reply via email to