Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.4-Linux/10/
Java: 32bit/jdk1.8.0_112 -client -XX:+UseG1GC

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.core.MetricsDirectoryFactory.get(MetricsDirectoryFactory.java:201)
  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:397) 
 at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
  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.core.MetricsDirectoryFactory.get(MetricsDirectoryFactory.java:201)
        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:397)
        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
        at java.lang.Thread.run(Thread.java:745)


        at __randomizedtesting.SeedInfo.seed([5B23FA6202D52758]: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.GeneratedMethodAccessor19.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 11964 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_5B23FA6202D52758-001/init-core-data-001
   [junit4]   2> 1127592 INFO  
(SUITE-TestReplicationHandler-seed#[5B23FA6202D52758]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
   [junit4]   2> 1127594 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
   [junit4]   2> 1127594 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/collection1
   [junit4]   2> 1127599 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1127601 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1cc2894{/solr,null,AVAILABLE}
   [junit4]   2> 1127602 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@2de43b{HTTP/1.1,[http/1.1]}{127.0.0.1:43984}
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1129319ms
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=43984}
   [junit4]   2> 1127603 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1127603 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:41.695Z
   [junit4]   2> 1127604 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/solr.xml
   [junit4]   2> 1127613 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1127618 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/.
   [junit4]   2> 1127618 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1127628 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1127639 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1127642 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1127643 INFO  (coreLoadExecutor-3207-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_5B23FA6202D52758-001/solr-instance-001/./collection1
   [junit4]   2> 1127644 INFO  (coreLoadExecutor-3207-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_5B23FA6202D52758-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1127645 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1127657 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1127657 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1127658 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1127658 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@8400c8[collection1] 
main]
   [junit4]   2> 1127659 INFO  (coreLoadExecutor-3207-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_5B23FA6202D52758-001/solr-instance-001/collection1/conf
   [junit4]   2> 1127659 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1127659 INFO  (coreLoadExecutor-3207-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1127660 INFO  
(searcherExecutor-3208-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@8400c8[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1128116 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/collection1
   [junit4]   2> 1128119 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1128120 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@a53a1c{/solr,null,AVAILABLE}
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@110381b{HTTP/1.1,[http/1.1]}{127.0.0.1:44410}
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1129838ms
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=44410}
   [junit4]   2> 1128122 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1128122 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:42.214Z
   [junit4]   2> 1128123 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/solr.xml
   [junit4]   2> 1128130 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1128134 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/.
   [junit4]   2> 1128134 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1128145 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1128156 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1128159 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1128161 INFO  (coreLoadExecutor-3217-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_5B23FA6202D52758-001/solr-instance-002/./collection1
   [junit4]   2> 1128161 INFO  (coreLoadExecutor-3217-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_5B23FA6202D52758-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1128164 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1128177 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1128177 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1128177 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1128178 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@290775[collection1] 
main]
   [junit4]   2> 1128178 INFO  (coreLoadExecutor-3217-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_5B23FA6202D52758-001/solr-instance-002/collection1/conf
   [junit4]   2> 1128180 INFO  (coreLoadExecutor-3217-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1128180 INFO  
(searcherExecutor-3218-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@290775[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1128628 INFO  (qtp28082431-6284) [    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> 1128630 INFO  (indexFetcher-3222-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1128630 INFO  (indexFetcher-3222-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1128630 INFO  (indexFetcher-3222-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1128648 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@110381b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1128649 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=30483026
   [junit4]   2> 1128654 INFO  (coreCloseExecutor-3223-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@e4f8fb
   [junit4]   2> 1128655 INFO  (coreCloseExecutor-3223-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1128655 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1128656 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@a53a1c{/solr,null,UNAVAILABLE}
   [junit4]   2> 1128663 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@2de43b{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1128664 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=23038618
   [junit4]   2> 1128665 INFO  (coreCloseExecutor-3225-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@f70271
   [junit4]   2> 1128665 INFO  (coreCloseExecutor-3225-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1128665 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1128666 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@1cc2894{/solr,null,UNAVAILABLE}
   [junit4]   2> 1128667 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1128669 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@677b64{/solr,null,AVAILABLE}
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@122f28d{HTTP/1.1,[http/1.1]}{127.0.0.1:34496}
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1130386ms
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/collection1/data,
 hostContext=/solr, hostPort=34496}
   [junit4]   2> 1128670 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1128670 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:42.762Z
   [junit4]   2> 1128671 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/solr.xml
   [junit4]   2> 1128676 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1128681 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-001/.
   [junit4]   2> 1128681 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1128691 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1128708 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1128712 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1128713 INFO  (coreLoadExecutor-3232-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_5B23FA6202D52758-001/solr-instance-001/./collection1
   [junit4]   2> 1128714 INFO  (coreLoadExecutor-3232-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_5B23FA6202D52758-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1128717 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1128735 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1128735 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1128736 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1128737 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1130eee[collection1] 
main]
   [junit4]   2> 1128737 INFO  (coreLoadExecutor-3232-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_5B23FA6202D52758-001/solr-instance-001/collection1/conf
   [junit4]   2> 1128737 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml
   [junit4]   2> 1128737 INFO  (coreLoadExecutor-3232-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1128738 INFO  
(searcherExecutor-3233-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1130eee[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129167 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 1129167 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 1129170 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1129170 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@dc1b35
   [junit4]   2> 1129173 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@126fca5[collection1] main]
   [junit4]   2> 1129173 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1129173 INFO  
(searcherExecutor-3233-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@126fca5[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129173 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 3
   [junit4]   2> 1129176 INFO  (qtp4791548-6326) [    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> 1129177 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 1129206 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1129207 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@15fa8d{/solr,null,AVAILABLE}
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@df79d2{HTTP/1.1,[http/1.1]}{127.0.0.1:35582}
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1130925ms
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/collection1/data,
 hostContext=/solr, hostPort=35582}
   [junit4]   2> 1129209 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1129209 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:43.301Z
   [junit4]   2> 1129210 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/solr.xml
   [junit4]   2> 1129220 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1129225 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-002/.
   [junit4]   2> 1129225 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1129236 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1129245 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1129255 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1129257 INFO  (coreLoadExecutor-3242-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_5B23FA6202D52758-001/solr-instance-002/./collection1
   [junit4]   2> 1129257 INFO  (coreLoadExecutor-3242-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_5B23FA6202D52758-001/solr-instance-002/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 1129259 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1129270 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1129271 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1129271 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1129272 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@10ece4f[collection1] 
main]
   [junit4]   2> 1129272 INFO  (coreLoadExecutor-3242-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_5B23FA6202D52758-001/solr-instance-002/collection1/conf
   [junit4]   2> 1129273 INFO  (coreLoadExecutor-3242-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1129274 INFO  
(searcherExecutor-3243-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@10ece4f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129275 INFO  (qtp4791548-6324) [    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> 1129276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 1129276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1484552683262
   [junit4]   2> 1129276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1129276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1129281 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=2
   [junit4]   2> 1129281 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 1
   [junit4]   2> 1129283 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: 
minMergeSize=1000, mergeFactor=37, maxMergeSize=9223372036854775807, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.0]
   [junit4]   2> 1129285 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1129285 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@13092a7 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@592364))
   [junit4]   2> 1129288 INFO  (qtp4791548-6326) [    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> 1129289 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=100) : 0 secs (null bytes/sec) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@13092a7 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@592364))
   [junit4]   2> 1129291 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=64.087890625, 
floorSegmentMB=0.5234375, forceMergeDeletesPctAllowed=26.10180864045611, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.30801686065928147
   [junit4]   2> 1129293 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1129294 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@59ca18[collection1] main]
   [junit4]   2> 1129294 INFO  
(searcherExecutor-3243-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@59ca18[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129755 INFO  (qtp8666172-6342) [    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> 1129756 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
   [junit4]   2> 1129759 INFO  (qtp4791548-6319) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1129762 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} 
status=0 QTime=0
   [junit4]   2> 1129777 INFO  (qtp4791548-6321) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1129787 INFO  (qtp4791548-6321) [    ] o.a.s.s.IndexSchema 
[collection1] Schema name=test
   [junit4]   2> 1129789 INFO  (qtp4791548-6321) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1129790 INFO  (qtp4791548-6321) [    ] o.a.s.c.CoreContainer 
Reloading SolrCore 'collection1' using configuration from instancedir 
/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-001/./collection1
   [junit4]   2> 1129791 INFO  (qtp4791548-6321) [    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_5B23FA6202D52758-001/solr-instance-001/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 1129805 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1129805 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1129805 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@dfd09f[collection1] main]
   [junit4]   2> 1129805 INFO  (qtp4791548-6321) [    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_5B23FA6202D52758-001/solr-instance-001/collection1/conf
   [junit4]   2> 1129805 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.h.ReplicationHandler Replication enabled for following config files: 
schema.xml
   [junit4]   2> 1129806 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1129806 INFO  
(searcherExecutor-3249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@dfd09f[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129808 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: 
minMergeSize=0, mergeFactor=10, maxMergeSize=1348151834, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.1]
   [junit4]   2> 1129809 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1129809 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1c6202d[collection1] main]
   [junit4]   2> 1129809 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1773e82
   [junit4]   2> 1129809 INFO  
(searcherExecutor-3249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1c6202d[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1129810 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1129810 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={core=collection1&qt=/admin/cores&action=reload&wt=javabin&version=2} 
status=0 QTime=43
   [junit4]   2> 1129812 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
 status=0 QTime=0
   [junit4]   2> 1129815 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits} 
status=0 QTime=0
   [junit4]   2> 1129819 INFO  (qtp4791548-6319) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 1
   [junit4]   2> 1129822 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1129825 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 1129825 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@1ac0e6e
   [junit4]   2> 1129830 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d5912a[collection1] main]
   [junit4]   2> 1129830 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 1129830 INFO  
(searcherExecutor-3249-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@1d5912a[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C2)))}
   [junit4]   2> 1129831 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=}
 0 5
   [junit4]   2> 1129835 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 1129836 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
   [junit4]   2> 1129838 INFO  (qtp8666172-6343) [    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> 1129839 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 1129942 INFO  (qtp8666172-6344) [    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> 1129942 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 1130045 INFO  (qtp8666172-6337) [    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> 1130045 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 1130148 INFO  (qtp8666172-6342) [    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> 1130148 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 1130251 INFO  (qtp8666172-6343) [    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> 1130251 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
   [junit4]   2> 1130275 INFO  (qtp4791548-6320) [    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> 1130276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 3
   [junit4]   2> 1130276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 1484552683917
   [junit4]   2> 1130276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 2
   [junit4]   2> 1130276 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 1130279 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&wt=javabin&version=2&command=filelist} 
status=0 QTime=1
   [junit4]   2> 1130280 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Number of files in latest index in master: 10
   [junit4]   2> 1130281 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=50, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=29.818359375, 
floorSegmentMB=1.5751953125, forceMergeDeletesPctAllowed=5.872612293050414, 
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.42642125588207846
   [junit4]   2> 1130281 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1130282 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@e38648 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ffff2b))
   [junit4]   2> 1130284 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130287 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_Lucene50_0.doc&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130290 INFO  (qtp4791548-6320) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_Lucene50_0.tim&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130293 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130296 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130298 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0_Lucene50_0.tip&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130301 INFO  (qtp4791548-6320) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130303 INFO  (qtp4791548-6324) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130305 INFO  (qtp4791548-6325) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130308 INFO  (qtp4791548-6321) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication 
params={generation=3&qt=/replication&file=segments_3&checksum=true&wt=filestream&command=filecontent}
 status=0 QTime=0
   [junit4]   2> 1130309 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Total time taken for download 
(fullCopy=false,bytesDownloaded=1663) : 0 secs (null bytes/sec) to 
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@e38648 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@ffff2b))
   [junit4]   2> 1130310 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: 
minMergeSize=1677721, mergeFactor=11, maxMergeSize=2147483648, 
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, 
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=1.0]
   [junit4]   2> 1130312 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 1130313 INFO  (indexFetcher-3247-thread-1) [    x:collection1] 
o.a.s.s.SolrIndexSearcher Opening [Searcher@74e6fe[collection1] main]
   [junit4]   2> 1130313 INFO  
(searcherExecutor-3243-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@74e6fe[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C2)))}
   [junit4]   2> 1130355 INFO  (qtp8666172-6344) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=/solr path=/select 
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
   [junit4]   2> 1130356 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.h.TestReplicationHandler Waited for 500ms and found 2 docs
   [junit4]   2> 1130356 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
   [junit4]   2> 1130357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@122f28d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1130357 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2360345
   [junit4]   2> 1130358 INFO  (coreCloseExecutor-3254-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@456bcb
   [junit4]   2> 1130359 INFO  (coreCloseExecutor-3254-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1130359 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1130360 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@677b64{/solr,null,UNAVAILABLE}
   [junit4]   2> 1130361 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@df79d2{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1130361 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=31555626
   [junit4]   2> 1130362 INFO  (coreCloseExecutor-3256-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1456bcd
   [junit4]   2> 1130363 INFO  (coreCloseExecutor-3256-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1130363 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1130364 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@15fa8d{/solr,null,UNAVAILABLE}
   [junit4]   2> 1130367 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterWrite2Slave
   [junit4]   2> 1130368 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-003/collection1
   [junit4]   2> 1130373 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1130374 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@19cbe01{/solr,null,AVAILABLE}
   [junit4]   2> 1130375 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@16750b3{HTTP/1.1,[http/1.1]}{127.0.0.1:41768}
   [junit4]   2> 1130375 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1132091ms
   [junit4]   2> 1130375 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-003/collection1/data,
 hostContext=/solr, hostPort=41768}
   [junit4]   2> 1130376 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1130376 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1130376 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1130376 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1130376 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:44.468Z
   [junit4]   2> 1130377 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-003/solr.xml
   [junit4]   2> 1130387 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1130393 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-003/.
   [junit4]   2> 1130393 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1130404 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1130417 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1130421 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1130422 INFO  (coreLoadExecutor-3263-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_5B23FA6202D52758-001/solr-instance-003/./collection1
   [junit4]   2> 1130423 INFO  (coreLoadExecutor-3263-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_5B23FA6202D52758-001/solr-instance-003/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-003/./collection1/data/]
   [junit4]   2> 1130425 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1130443 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1130443 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1130444 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1130445 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@bb1c25[collection1] 
main]
   [junit4]   2> 1130446 INFO  (coreLoadExecutor-3263-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_5B23FA6202D52758-001/solr-instance-003/collection1/conf
   [junit4]   2> 1130446 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following 
config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 1130446 INFO  (coreLoadExecutor-3263-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1130446 INFO  
(searcherExecutor-3264-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@bb1c25[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1131146 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-004/collection1
   [junit4]   2> 1131149 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1131149 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@1b70fd2{/solr,null,AVAILABLE}
   [junit4]   2> 1131150 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Started 
ServerConnector@1339a29{HTTP/1.1,[http/1.1]}{127.0.0.1:36064}
   [junit4]   2> 1131150 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.Server Started @1132866ms
   [junit4]   2> 1131150 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-004/collection1/data,
 hostContext=/solr, hostPort=36064}
   [junit4]   2> 1131150 ERROR 
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging 
may be missing or incomplete.
   [junit4]   2> 1131150 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ 
version 6.4.0
   [junit4]   2> 1131151 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone 
mode on port null
   [junit4]   2> 1131151 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1131151 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-01-16T07:44:45.243Z
   [junit4]   2> 1131151 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-004/solr.xml
   [junit4]   2> 1131158 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with 
params: socketTimeout=340000&connTimeout=45000&retry=true
   [junit4]   2> 1131162 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] 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_5B23FA6202D52758-001/solr-instance-004/.
   [junit4]   2> 1131163 INFO  
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 1131174 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
   [junit4]   2> 1131186 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1131189 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 1131190 INFO  (coreLoadExecutor-3273-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_5B23FA6202D52758-001/solr-instance-004/./collection1
   [junit4]   2> 1131190 INFO  (coreLoadExecutor-3273-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_5B23FA6202D52758-001/solr-instance-004/collection1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-6.4-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-004/./collection1/data/]
   [junit4]   2> 1131193 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1131206 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1131206 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1131207 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1131208 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3ab2ae[collection1] 
main]
   [junit4]   2> 1131208 INFO  (coreLoadExecutor-3273-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_5B23FA6202D52758-001/solr-instance-004/collection1/conf
   [junit4]   2> 1131209 INFO  (coreLoadExecutor-3273-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1131209 INFO  
(searcherExecutor-3274-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@3ab2ae[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1131225 INFO  (qtp8127433-6369) [    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> 1131225 INFO  (indexFetcher-3278-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1131225 INFO  (indexFetcher-3278-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1131225 INFO  (indexFetcher-3278-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1131675 INFO  (qtp8127433-6365) [    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> 1131681 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[0]} 0 2
   [junit4]   2> 1131684 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 1131686 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 1131689 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 1131693 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 1131695 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 1131697 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 1131702 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[7]} 0 2
   [junit4]   2> 1131706 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 1131708 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 1131711 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 1131713 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 1131717 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 1131720 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 1131722 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 1131726 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[15]} 0 1
   [junit4]   2> 1131729 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 1131732 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 1131735 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 1131738 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 1131741 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 1131744 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 1131747 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 1131753 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[23]} 0 4
   [junit4]   2> 1131758 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[24]} 0 2
   [junit4]   2> 1131762 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 1131768 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 1131771 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 1131773 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 1131777 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[29]} 0 1
   [junit4]   2> 1131779 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 1131784 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[31]} 0 2
   [junit4]   2> 1131787 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[32]} 0 0
   [junit4]   2> 1131791 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 1131794 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 1131796 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 1131799 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 1131803 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 1131805 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 1131809 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[39]} 0 1
   [junit4]   2> 1131813 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 1131816 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 1131818 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 1131821 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[43]} 0 0
   [junit4]   2> 1131825 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[44]} 0 1
   [junit4]   2> 1131827 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 1131830 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 1131833 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[47]} 0 1
   [junit4]   2> 1131837 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 1131840 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 1131842 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 1131845 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 1131849 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 1131851 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[53]} 0 0
   [junit4]   2> 1131854 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[54]} 0 0
   [junit4]   2> 1131858 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[55]} 0 1
   [junit4]   2> 1131862 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 1131864 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 1131867 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 1131869 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 1131872 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[60]} 0 1
   [junit4]   2> 1131875 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 1131877 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 1131881 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[63]} 0 1
   [junit4]   2> 1131885 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[64]} 0 1
   [junit4]   2> 1131887 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[65]} 0 0
   [junit4]   2> 1131890 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[66]} 0 0
   [junit4]   2> 1131892 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[67]} 0 0
   [junit4]   2> 1131894 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[68]} 0 0
   [junit4]   2> 1131897 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[69]} 0 0
   [junit4]   2> 1131899 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[70]} 0 0
   [junit4]   2> 1131904 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[71]} 0 2
   [junit4]   2> 1131907 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[72]} 0 0
   [junit4]   2> 1131910 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[73]} 0 0
   [junit4]   2> 1131913 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[74]} 0 0
   [junit4]   2> 1131916 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[75]} 0 0
   [junit4]   2> 1131918 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[76]} 0 0
   [junit4]   2> 1131921 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[77]} 0 0
   [junit4]   2> 1131923 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[78]} 0 0
   [junit4]   2> 1131928 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[79]} 0 2
   [junit4]   2> 1131931 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[80]} 0 0
   [junit4]   2> 1131934 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[81]} 0 0
   [junit4]   2> 1131936 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[82]} 0 0
   [junit4]   2> 1131939 INFO  (qtp8127433-6369) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[83]} 0 0
   [junit4]   2> 1131941 INFO  (qtp8127433-6364) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[84]} 0 0
   [junit4]   2> 1131944 INFO  (qtp8127433-6371) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[85]} 0 0
   [junit4]   2> 1131947 INFO  (qtp8127433-6365) [    x:collection1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update 
params={wt=javabin&version=2}{add=[86]} 0 0
   [junit4]   2> 1131951 INF

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

re/test/J0/temp/solr.handler.TestReplicationHandler_5B23FA6202D52758-001/solr-instance-030/./collection1/data/]
   [junit4]   2> 1237114 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=19, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=82.2548828125, 
floorSegmentMB=1.5634765625, forceMergeDeletesPctAllowed=19.22650226071619, 
segmentsPerTier=26.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
   [junit4]   2> 1237131 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1237131 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1237131 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class 
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: 
maxMergeAtOnce=20, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=54.9345703125, 
floorSegmentMB=1.1123046875, forceMergeDeletesPctAllowed=28.212352349012473, 
segmentsPerTier=42.0, maxCFSSegmentSizeMB=8.796093022207999E12, 
noCFSRatio=0.3385534430386723
   [junit4]   2> 1237132 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@11a1259[collection1] 
main]
   [junit4]   2> 1237133 INFO  (coreLoadExecutor-3859-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_5B23FA6202D52758-001/solr-instance-030/collection1/conf
   [junit4]   2> 1237135 INFO  (coreLoadExecutor-3859-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 
1000ms
   [junit4]   2> 1237136 INFO  
(searcherExecutor-3860-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@11a1259[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1237138 INFO  (qtp28250337-7318) [    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> 1237139 INFO  (indexFetcher-3864-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 1237139 INFO  (indexFetcher-3864-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 1237139 INFO  (indexFetcher-3864-thread-1) [    x:collection1] 
o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 1237612 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.a.s.SolrTestCaseJ4 ###Ending doTestHandlerPathUnchanged
   [junit4]   2> 1237613 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@198fa43{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1237613 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=15573326
   [junit4]   2> 1237613 INFO  (coreCloseExecutor-3865-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@158b1ea
   [junit4]   2> 1237614 INFO  (coreCloseExecutor-3865-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1237614 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1237614 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@50f055{/solr,null,UNAVAILABLE}
   [junit4]   2> 1237618 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.AbstractConnector Stopped 
ServerConnector@27884f{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 1237618 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=24756449
   [junit4]   2> 1237618 INFO  (coreCloseExecutor-3867-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@9079de
   [junit4]   2> 1237619 INFO  (coreCloseExecutor-3867-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: 
solr.core.collection1
   [junit4]   2> 1237619 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 1237619 INFO  
(TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[5B23FA6202D52758])
 [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@c66829{/solr,null,UNAVAILABLE}
   [junit4]   2> 1237622 INFO  
(SUITE-TestReplicationHandler-seed#[5B23FA6202D52758]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene62): 
{name=Lucene50(blocksize=128), id=Lucene50(blocksize=128), 
newname=Lucene50(blocksize=128)}, docValues:{}, maxPointsInLeafNode=1683, 
maxMBSortInHeap=6.714783992199788, 
sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=ar-AE, 
timezone=Etc/GMT+3
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 1.8.0_112 
(32-bit)/cpus=12,threads=1,free=435890976,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [TestExceedMaxTermLength, 
CloudMLTQParserTest, BasicZkTest, DistributedSpellCheckComponentTest, 
SolrXmlInZkTest, RuleEngineTest, TestRangeQuery, 
ManagedSchemaRoundRobinCloudTest, TestRealTimeGet, 
DistribDocExpirationUpdateProcessorTest, BlockJoinFacetRandomTest, 
TestReplicationHandlerBackup, CdcrReplicationDistributedZkTest, 
AddSchemaFieldsUpdateProcessorFactoryTest, AnalyticsMergeStrategyTest, 
TestBulkSchemaConcurrent, TestSortByMinMaxFunction, 
ConjunctionSolrSpellCheckerTest, CreateCollectionCleanupTest, 
TestHighlightDedupGrouping, TestFastWriter, TestFileDictionaryLookup, 
TestChildDocTransformer, AlternateDirectoryTest, TestCorePropertiesReload, 
TestPerFieldSimilarityWithDefaultOverride, NotRequiredUniqueKeyTest, 
DistributedQueryElevationComponentTest, DistributedVersionInfoTest, 
RegexBoostProcessorTest, DistanceUnitsTest, SolrCoreTest, 
TestSchemalessBufferedUpdates, QueryEqualityTest, TestFastLRUCache, 
ExplicitHLLTest, TestFieldCacheSort, TestRawResponseWriter, 
TestReRankQParserPlugin, TestFunctionQuery, TestIBSimilarityFactory, 
TestReplicaProperties, BasicDistributedZkTest, ExternalFileFieldSortTest, 
TestDynamicFieldResource, TestSearcherReuse, TestCloudSchemaless, 
CursorPagingTest, ScriptEngineTest, TestRandomFlRTGCloud, TestConfigSetsAPI, 
HdfsBasicDistributedZkTest, SignatureUpdateProcessorFactoryTest, 
TestJmxIntegration, StandardRequestHandlerTest, HttpPartitionTest, 
TestLazyCores, TestNumericTerms64, FastVectorHighlighterTest, 
TestIntervalFaceting, TestSolrCloudSnapshots, MergeStrategyTest, 
PreAnalyzedUpdateProcessorTest, DateRangeFieldTest, TestBinaryResponseWriter, 
TestComplexPhraseLeadingWildcard, ZkStateReaderTest, SynonymTokenizerTest, 
TestUniqueKeyFieldResource, TestQueryWrapperFilter, 
TestLeaderElectionWithEmptyReplica, BlockCacheTest, ReturnFieldsTest, 
ChaosMonkeyNothingIsSafeTest, ReplicaListTransformerTest, TestNRTOpen, 
TestFieldCacheWithThreads, TestCrossCoreJoin, SolrSlf4jReporterTest, 
TestDistribIDF, TestOmitPositions, CurrencyFieldOpenExchangeTest, 
JSONWriterTest, TestSchemaResource, DocumentAnalysisRequestHandlerTest, 
TestRandomFaceting, PathHierarchyTokenizerFactoryTest, TestSolrCoreProperties, 
SimpleCollectionCreateDeleteTest, DistributedFacetPivotSmallTest, 
TestDocumentBuilder, BadCopyFieldTest, HighlighterConfigTest, TestJoin, 
TestSerializedLuceneMatchVersion, MigrateRouteKeyTest, UUIDFieldTest, 
TriLevelCompositeIdRoutingTest, DefaultValueUpdateProcessorTest, 
TestPseudoReturnFields, TestReplicationHandler]
   [junit4]   2> NOTE: reproduce with: ant test  
-Dtestcase=TestReplicationHandler -Dtests.seed=5B23FA6202D52758 
-Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar-AE 
-Dtests.timezone=Etc/GMT+3 -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [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.core.MetricsDirectoryFactory.get(MetricsDirectoryFactory.java:201)
   [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:397)
   [junit4]    >        at 
org.apache.solr.handler.ReplicationHandler.lambda$handleRequestBody$0(ReplicationHandler.java:279)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([5B23FA6202D52758]:0)
   [junit4]    >        at 
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:269)
   [junit4]    >        at java.lang.Thread.run(Thread.java:745)
   [junit4] Completed [368/680 (1!)] on J0 in 141.20s, 15 tests, 1 failure, 1 
skipped <<< FAILURES!

[...truncated 55683 lines...]

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

Reply via email to