Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.4-Linux/160/
Java: 32bit/jdk1.8.0_121 -server -XX:+UseSerialGC

1 tests failed.
FAILED:  
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler

Error Message:
ObjectTracker found 1 object(s) that were not released!!! [NRTCachingDirectory] 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException  at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
  at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
  at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:369)  
at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251) 
 at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:399) 
 at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:281)
  at java.lang.Thread.run(Thread.java:745)  

Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not 
released!!! [NRTCachingDirectory]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
        at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:369)
        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251)
        at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:399)
        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:281)
        at java.lang.Thread.run(Thread.java:745)


        at __randomizedtesting.SeedInfo.seed([FECC6B382E176A46]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNull(Assert.java:551)
        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:269)
        at sun.reflect.GeneratedMethodAccessor25.invoke(Unknown Source)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
        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 12119 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/init-core-data-001
   [junit4]   2> 1080829 INFO  
(SUITE-TestReplicationHandler-seed#[FECC6B382E176A46]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 1080832 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testRateLimitedReplication
   [junit4]   2> 1080832 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1
   [junit4]   2> 1080835 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1080836 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1fc38af{/solr,null,AVAILABLE}
   [junit4]   2> 1080837 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@1de3457{HTTP/1.1,[http/1.1]}{127.0.0.1:43496}
   [junit4]   2> 1080837 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server Started @1082744ms
   [junit4]   2> 1080837 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=43496}
   [junit4]   2> 1080838 ERROR 
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1080838 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 6.4.3
   [junit4]   2> 1080838 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1080838 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1080838 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:42.034Z
   [junit4]   2> 1080838 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/solr.xml
   [junit4]   2> 1080844 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1080847 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/.
   [junit4]   2> 1080847 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1080866 WARN  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1080867 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1080875 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1080877 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1080878 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1
   [junit4]   2> 1080879 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1080881 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=54.3095703125, 
floorSegmentMB=1.0478515625, forceMergeDeletesPctAllowed=7.730683800090455, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1080891 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1080891 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1080891 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.33606746389117337]
   [junit4]   2> 1080891 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f91799[collection1] 
main]
   [junit4]   2> 1080892 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/conf
   [junit4]   2> 1080892 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1080893 INFO  (coreLoadExecutor-3208-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1080893 INFO  
(searcherExecutor-3209-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1f91799[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1081034 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1
   [junit4]   2> 1081036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1081037 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@15f6928{/solr,null,AVAILABLE}
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@1a3fab0{HTTP/1.1,[http/1.1]}{127.0.0.1:40738}
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server Started @1082944ms
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=40738}
   [junit4]   2> 1081038 ERROR 
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 6.4.3
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1081038 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:42.234Z
   [junit4]   2> 1081039 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/solr.xml
   [junit4]   2> 1081042 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1081045 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/.
   [junit4]   2> 1081045 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1081053 WARN  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1081065 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1081070 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1081072 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1081073 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/./collection1
   [junit4]   2> 1081073 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1081075 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=54.3095703125, 
floorSegmentMB=1.0478515625, forceMergeDeletesPctAllowed=7.730683800090455, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1081081 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1081081 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1081082 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.33606746389117337]
   [junit4]   2> 1081082 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@96fded[collection1] 
main]
   [junit4]   2> 1081082 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/conf
   [junit4]   2> 1081084 INFO  (coreLoadExecutor-3218-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1081084 INFO  
(searcherExecutor-3219-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@96fded[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1081255 INFO  (qtp22405322-8050) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1081256 INFO  (qtp22405322-8050) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1081257 INFO  (qtp23985983-8067) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1081257 INFO  (qtp23985983-8067) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1081259 INFO  (qtp22405322-8051) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1081259 INFO  (qtp22405322-8051) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1e728b6
   [junit4]   2> 1081260 INFO  (qtp22405322-8051) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1dc241[collection1] main]
   [junit4]   2> 1081260 INFO  (qtp22405322-8051) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1081260 INFO  
(searcherExecutor-3209-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1dc241[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1081260 INFO  (qtp22405322-8051) [    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> 1081262 INFO  (qtp23985983-8068) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1081262 INFO  (qtp23985983-8068) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1f11742
   [junit4]   2> 1081263 INFO  (qtp23985983-8068) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@becb7[collection1] main]
   [junit4]   2> 1081263 INFO  (qtp23985983-8068) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1081263 INFO  
(searcherExecutor-3219-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@becb7[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1081263 INFO  (qtp23985983-8068) [    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> 1081264 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@1de3457{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1081264 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=13094756
   [junit4]   2> 1081265 INFO  (coreCloseExecutor-3224-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@190e360
   [junit4]   2> 1081265 INFO  (coreCloseExecutor-3224-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1081265 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1081265 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1fc38af{/solr,null,UNAVAILABLE}
   [junit4]   2> 1081266 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@1a3fab0{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1081266 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=23802900
   [junit4]   2> 1081267 INFO  (coreCloseExecutor-3226-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@32970e
   [junit4]   2> 1081267 INFO  (coreCloseExecutor-3226-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1081268 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1081268 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@15f6928{/solr,null,UNAVAILABLE}
   [junit4]   2> 1081269 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1081270 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@ac5cae{/solr,null,AVAILABLE}
   [junit4]   2> 1081270 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@1ded611{HTTP/1.1,[http/1.1]}{127.0.0.1:39376}
   [junit4]   2> 1081270 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server Started @1083177ms
   [junit4]   2> 1081270 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=39376}
   [junit4]   2> 1081271 ERROR 
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1081271 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 6.4.3
   [junit4]   2> 1081271 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1081271 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1081271 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:42.467Z
   [junit4]   2> 1081271 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/solr.xml
   [junit4]   2> 1081275 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1081279 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/.
   [junit4]   2> 1081279 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1081296 WARN  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1081296 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1081303 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1081305 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1081306 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1
   [junit4]   2> 1081306 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1081308 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@55112b
   [junit4]   2> 1081341 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1081341 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1081342 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4407021756807983]
   [junit4]   2> 1081342 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@482514[collection1] 
main]
   [junit4]   2> 1081342 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/conf
   [junit4]   2> 1081342 INFO  (coreLoadExecutor-3233-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1081343 INFO  
(searcherExecutor-3234-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@482514[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1081444 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 1081447 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1081448 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1081450 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1081452 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1081454 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 1081456 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 1081458 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 1081460 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 1081462 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 1081464 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 1081467 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[11]} 0 1
   [junit4]   2> 1081470 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 1081472 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 1081473 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 1081475 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 1081478 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 1081480 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 1081482 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 1081484 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 1081486 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1081488 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 1081489 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 1081491 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 1081494 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[24]} 0 1
   [junit4]   2> 1081497 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 1081499 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 1081500 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 1081502 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 1081504 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 1081506 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 1081508 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 1081510 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[32]} 0 0
   [junit4]   2> 1081512 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 1081516 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[34]} 0 1
   [junit4]   2> 1081518 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 1081520 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 1081522 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 1081524 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 1081526 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 1081529 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[40]} 0 1
   [junit4]   2> 1081530 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 1081532 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 1081533 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[43]} 0 0
   [junit4]   2> 1081535 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[44]} 0 0
   [junit4]   2> 1081536 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 1081538 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 1081541 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[47]} 0 0
   [junit4]   2> 1081542 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 1081544 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 1081545 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 1081547 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 1081548 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 1081551 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[53]} 0 0
   [junit4]   2> 1081552 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[54]} 0 0
   [junit4]   2> 1081554 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[55]} 0 0
   [junit4]   2> 1081555 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 1081557 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 1081559 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 1081561 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 1081562 INFO  (qtp126005-8086) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[60]} 0 0
   [junit4]   2> 1081564 INFO  (qtp126005-8092) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 1081566 INFO  (qtp126005-8093) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 1081567 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1081567 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@fc21e7
   [junit4]   2> 1081855 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@17fc4fe[collection1] main]
   [junit4]   2> 1081856 INFO  (qtp126005-8091) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1081856 INFO  
(searcherExecutor-3234-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@17fc4fe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.3):c63)))}
   [junit4]   2> 1081856 INFO  (qtp126005-8091) [    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 288
   [junit4]   2> 1081857 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@1ded611{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1081857 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16460537
   [junit4]   2> 1081857 INFO  (coreCloseExecutor-3238-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@100337b
   [junit4]   2> 1081858 INFO  (coreCloseExecutor-3238-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1081858 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1081859 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@ac5cae{/solr,null,UNAVAILABLE}
   [junit4]   2> 1081860 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1081861 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1fea286{/solr,null,AVAILABLE}
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@199c4c4{HTTP/1.1,[http/1.1]}{127.0.0.1:39606}
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server Started @1083768ms
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=39606}
   [junit4]   2> 1081862 ERROR 
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 6.4.3
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1081862 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:43.058Z
   [junit4]   2> 1081863 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/solr.xml
   [junit4]   2> 1081867 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1081871 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/.
   [junit4]   2> 1081871 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1081878 WARN  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1081878 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1081884 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1081885 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1081886 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1
   [junit4]   2> 1081886 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1081893 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1081893 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1081894 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@f5f855
   [junit4]   2> 1081895 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a59f27[collection1] 
main]
   [junit4]   2> 1081895 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-001/collection1/conf
   [junit4]   2> 1081895 INFO  (coreLoadExecutor-3245-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1081896 INFO  
(searcherExecutor-3246-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1a59f27[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.3):c63)))}
   [junit4]   2> 1082034 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1082035 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@fd7430{/solr,null,AVAILABLE}
   [junit4]   2> 1082035 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@34205f{HTTP/1.1,[http/1.1]}{127.0.0.1:33930}
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.Server Started @1083942ms
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=33930}
   [junit4]   2> 1082036 ERROR 
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? 
version 6.4.3
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1082036 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:43.232Z
   [junit4]   2> 1082037 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/solr.xml
   [junit4]   2> 1082040 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1082043 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/.
   [junit4]   2> 1082043 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1082052 WARN  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1082053 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1082061 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1082063 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1082065 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/./collection1
   [junit4]   2> 1082065 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1082067 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@5ca889
   [junit4]   2> 1082106 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1082106 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1082106 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4407021756807983]
   [junit4]   2> 1082106 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@104c9a9[collection1] 
main]
   [junit4]   2> 1082107 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/conf
   [junit4]   2> 1082107 INFO  (coreLoadExecutor-3255-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1082107 INFO  
(searcherExecutor-3256-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@104c9a9[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1082229 WARN  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication 
suffix
   [junit4]   2> 1082230 INFO  (qtp12666577-8111) [    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> 1082231 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1082231 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1489041222764
   [junit4]   2> 1082231 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1082231 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1082233 INFO  (qtp12666577-8112) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=0
   [junit4]   2> 1082233 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 1082235 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.MockRandomMergePolicy: 
org.apache.lucene.index.MockRandomMergePolicy@f7970
   [junit4]   2> 1082235 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1082235 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/data/index.20170309003343429
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1138024
   [junit4]   2> 1082238 INFO  (qtp12666577-8113) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1082240 INFO  (qtp12666577-8106) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1082242 INFO  (qtp12666577-8111) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1087832 INFO  (qtp12666577-8112) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1087832 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=586551) : 5 secs (117310 bytes/sec) to 
NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-002/collection1/data/index.20170309003343429
 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@1138024
   [junit4]   2> 1087897 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=35, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.4407021756807983]
   [junit4]   2> 1087898 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1087898 INFO  (explicit-fetchindex-cmd) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@a391c[collection1] main]
   [junit4]   2> 1087898 INFO  
(searcherExecutor-3256-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@a391c[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.3):c63)))}
   [junit4]   2> 1087899 INFO  (qtp3799-8128) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={wait=true&masterUrl=http://127.0.0.1:39606/solr/collection1/replication&command=fetchindex}
 status=0 QTime=5670
   [junit4]   2> 1087910 INFO  (qtp12666577-8106) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[63]} 0 0
   [junit4]   2> 1087911 INFO  (qtp3799-8130) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=63 status=0 QTime=1
   [junit4]   2> 1087912 INFO  (qtp12666577-8111) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[64]} 0 0
   [junit4]   2> 1087914 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 63 docs
   [junit4]   2> 1087914 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.h.TestReplicationHandler approximateTimeInSeconds = 0.0 
timeTakenInSeconds = 5
   [junit4]   2> 1087914 INFO  (qtp12666577-8112) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[65]} 0 0
   [junit4]   2> 1087914 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending testRateLimitedReplication
   [junit4]   2> 1087914 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@199c4c4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1087915 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=10870952
   [junit4]   2> 1087916 INFO  (coreCloseExecutor-3261-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1b0be2a
   [junit4]   2> 1087917 INFO  (coreCloseExecutor-3261-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1087918 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1087918 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1fea286{/solr,null,UNAVAILABLE}
   [junit4]   2> 1087919 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@34205f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1087919 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=19862636
   [junit4]   2> 1087920 INFO  (coreCloseExecutor-3263-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@25e62c
   [junit4]   2> 1087920 INFO  (coreCloseExecutor-3263-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1087920 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1087921 INFO  
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@fd7430{/solr,null,UNAVAILABLE}
   [junit4]   2> 1087923 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting doTestStopPoll
   [junit4]   2> 1087923 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/collection1
   [junit4]   2> 1087926 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1087927 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@186a812{/solr,null,AVAILABLE}
   [junit4]   2> 1087927 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1d04294{HTTP/1.1,[http/1.1]}{127.0.0.1:44633}
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.Server Started @1089834ms
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/collection1/data,
 hostContext=/solr, hostPort=44633}
   [junit4]   2> 1087928 ERROR 
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.3
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:49.124Z
   [junit4]   2> 1087928 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/solr.xml
   [junit4]   2> 1087935 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1087940 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/.
   [junit4]   2> 1087940 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1087950 WARN  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1087951 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1087957 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1087959 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1087961 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/./collection1
   [junit4]   2> 1087961 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 1087962 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=54.3095703125, 
floorSegmentMB=1.0478515625, forceMergeDeletesPctAllowed=7.730683800090455, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1087978 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1087978 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1087978 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.33606746389117337]
   [junit4]   2> 1087979 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e296bc[collection1] 
main]
   [junit4]   2> 1087979 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-003/collection1/conf
   [junit4]   2> 1087979 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1087979 INFO  (coreLoadExecutor-3270-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1087979 INFO  
(searcherExecutor-3271-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1e296bc[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1088127 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/collection1
   [junit4]   2> 1088129 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1088130 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@840b37{/solr,null,AVAILABLE}
   [junit4]   2> 1088130 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5bff5b{HTTP/1.1,[http/1.1]}{127.0.0.1:45014}
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.e.j.s.Server Started @1090037ms
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: 
{solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/collection1/data,
 hostContext=/solr, hostPort=45014}
   [junit4]   2> 1088131 ERROR 
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
6.4.3
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1088131 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-03-09T06:33:49.327Z
   [junit4]   2> 1088132 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/solr.xml
   [junit4]   2> 1088135 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: 
socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1088138 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/.
   [junit4]   2> 1088138 INFO  
(TEST-TestReplicationHandler.doTestStopPoll-seed#[FECC6B382E176A46]) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1088145 WARN  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is 
deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 1088145 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.3
   [junit4]   2> 1088151 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1088152 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1088153 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/./collection1
   [junit4]   2> 1088153 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/./collection1/data/]
   [junit4]   2> 1088154 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=46, maxMergeAtOnceExplicit=12, maxMergedSegmentMB=54.3095703125, 
floorSegmentMB=1.0478515625, forceMergeDeletesPctAllowed=7.730683800090455, 
segmentsPerTier=25.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1088161 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1088161 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1088161 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=21, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.33606746389117337]
   [junit4]   2> 1088161 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@822f99[collection1] 
main]
   [junit4]   2> 1088161 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_FECC6B382E176A46-001/solr-instance-004/collection1/conf
   [junit4]   2> 1088162 INFO  (coreLoadExecutor-3280-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1088162 INFO  
(searcherExecutor-3281-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@822f99[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1088194 INFO  (qtp3151583-8155) [    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> 1088194 INFO  (indexFetcher-3285-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1088194 INFO  (indexFetcher-3285-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1088194 INFO  (indexFetcher-3285-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1088333 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=0 status=0 QTime=0
   [junit4]   2> 1088335 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 1088337 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1088338 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1088340 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1088341 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1088343 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 1088344 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 1088346 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 1088347 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 1088349 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 1088350 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 1088352 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 1088353 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 1088354 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 1088356 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 1088357 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 1088359 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 1088360 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 1088362 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 1088363 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 1088364 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1088366 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 1088367 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 1088369 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 1088371 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[24]} 0 0
   [junit4]   2> 1088372 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 1088374 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 1088375 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 1088377 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 1088378 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 1088380 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 1088381 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 1088383 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[32]} 0 0
   [junit4]   2> 1088384 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 1088386 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 1088387 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 1088389 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 1088390 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 1088392 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 1088394 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 1088395 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 1088396 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 1088398 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 1088399 INFO  (qtp3151583-8157) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[43]} 0 0
   [junit4]   2> 1088401 INFO  (qtp3151583-8151) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[44]} 0 0
   [junit4]   2> 1088402 INFO  (qtp3151583-8150) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 1088404 INFO  (qtp3151583-8155) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 1088405 INFO  (qtp3151583-8157) [    x:collection1] 

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

segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 1150154 INFO  (indexFetcher-3880-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1150155 INFO  (indexFetcher-3880-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@951646[collection1] main]
   [junit4]   2> 1150155 INFO  
(searcherExecutor-3882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@951646[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.3):c1)))}
   [junit4]   2> 1150313 INFO  (qtp2199658-9117) [    ] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={core=collection1&action=status&wt=javabin&version=2} status=0 QTime=0
   [junit4]   2> 1150315 INFO  (qtp10947370-9097) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2000&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1150315 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1150317 INFO  (qtp2199658-9116) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2000&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1150317 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1150319 INFO  (qtp2199658-9118) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2001]} 0 1
   [junit4]   2> 1150321 INFO  (qtp2199658-9117) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1150321 INFO  (qtp2199658-9117) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@13b2958
   [junit4]   2> 1150328 INFO  (qtp2199658-9117) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@f56fdf[collection1] main]
   [junit4]   2> 1150328 INFO  (qtp2199658-9117) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1150328 INFO  
(searcherExecutor-3882-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@f56fdf[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.3):c1)
 Uninverting(_1(6.4.3):c1)))}
   [junit4]   2> 1150328 INFO  (qtp2199658-9117) [    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 7
   [junit4]   2> 1150330 INFO  (qtp2199658-9123) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=id:2001&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
   [junit4]   2> 1150330 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
   [junit4]   2> 1150330 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestIndexAndConfigAliasReplication
   [junit4]   2> 1150331 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@1500d22{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1150331 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=27913076
   [junit4]   2> 1150332 INFO  (coreCloseExecutor-3887-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@48fe17
   [junit4]   2> 1150332 INFO  (coreCloseExecutor-3887-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1150332 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1150333 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@cde758{/solr,null,UNAVAILABLE}
   [junit4]   2> 1150333 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@4411ed{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1150333 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=33297619
   [junit4]   2> 1150337 INFO  (coreCloseExecutor-3889-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@cb4da7
   [junit4]   2> 1150337 INFO  (coreCloseExecutor-3889-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1150338 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1150338 INFO  
(TEST-TestReplicationHandler.doTestIndexAndConfigAliasReplication-seed#[FECC6B382E176A46])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@5f04a1{/solr,null,UNAVAILABLE}
   [junit4] IGNOR/A 0.00s J0 | 
TestReplicationHandler.doTestIndexFetchOnMasterRestart
   [junit4]    > Assumption #1: 'awaitsfix' test group is disabled 
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-9036))
   [junit4]   2> 1150339 INFO  
(SUITE-TestReplicationHandler-seed#[FECC6B382E176A46]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{name=PostingsFormat(name=Memory doPackFST= false), 
id=PostingsFormat(name=Memory doPackFST= false), 
newname=PostingsFormat(name=Memory doPackFST= false)}, docValues:{}, 
maxPointsInLeafNode=750, maxMBSortInHeap=6.341679787372387, 
sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=sq, 
timezone=America/Chicago
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 1.8.0_121 
(32-bit)/cpus=12,threads=1,free=141192240,total=324669440
   [junit4]   2> NOTE: All tests run in this JVM: [TestReplicaProperties, 
TestSolr4Spatial2, LeaderElectionIntegrationTest, HLLUtilTest, 
TestCloudRecovery, CdcrReplicationDistributedZkTest, 
HdfsBasicDistributedZkTest, CurrencyFieldOpenExchangeTest, DeleteShardTest, 
RollingRestartTest, BlockCacheTest, AlternateDirectoryTest, ActionThrottleTest, 
TestNamedUpdateProcessors, ShardSplitTest, OverseerRolesTest, 
DistributedQueryElevationComponentTest, TestSQLHandler, TestCloudInspectUtil, 
TestSubQueryTransformerDistrib, MBeansHandlerTest, 
ClassificationUpdateProcessorIntegrationTest, TestPHPSerializedResponseWriter, 
TestDynamicFieldResource, TestGraphMLResponseWriter, FastVectorHighlighterTest, 
QueryEqualityTest, TestCloudSchemaless, ReturnFieldsTest, 
TestBinaryResponseWriter, ZkStateReaderTest, LeaderFailureAfterFreshStartTest, 
CoreMergeIndexesAdminHandlerTest, SolrRequestParserTest, TestJsonFacets, 
TestConfigSetsAPI, DocExpirationUpdateProcessorFactoryTest, 
TestChildDocTransformer, TestManagedSchemaAPI, TestNRTOpen, 
FileBasedSpellCheckerTest, TestSizeLimitedDistributedMap, TestMissingGroups, 
HttpPartitionTest, TestFaceting, TestConfigSetImmutable, 
RegexBoostProcessorTest, HdfsRecoveryZkTest, TestAuthorizationFramework, 
TestQueryWrapperFilter, PathHierarchyTokenizerFactoryTest, TestSolr4Spatial, 
TestFieldTypeCollectionResource, TestLazyCores, CollectionTooManyReplicasTest, 
ManagedSchemaRoundRobinCloudTest, SynonymTokenizerTest, TestFieldSortValues, 
TestSchemaResource, JavabinLoaderTest, 
TestPerFieldSimilarityWithDefaultOverride, TestReplicationHandler]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestReplicationHandler -Dtests.seed=FECC6B382E176A46 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=sq 
-Dtests.timezone=America/Chicago -Dtests.asserts=true 
-Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J0 | TestReplicationHandler (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: ObjectTracker found 1 
object(s) that were not released!!! [NRTCachingDirectory]
   [junit4]    > 
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
   [junit4]    >        at 
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
   [junit4]    >        at 
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:347)
   [junit4]    >        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:369)
   [junit4]    >        at 
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251)
   [junit4]    >        at 
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:399)
   [junit4]    >        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:281)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([FECC6B382E176A46]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:269)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [427/680 (1!)] on J0 in 100.58s, 16 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 55553 lines...]

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

Reply via email to