You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/11/10 15:59:59 UTC
[JENKINS] Lucene-Solr-6.x-Linux (32bit/jdk1.8.0_102) - Build # 2147
- Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-Linux/2147/
Java: 32bit/jdk1.8.0_102 -client -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication
Error Message:
expected:<1> but was:<0>
Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
at __randomizedtesting.SeedInfo.seed([C8D4A8F29FD47336:3FA746AA593CDCD0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at org.junit.Assert.assertEquals(Assert.java:456)
at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1331)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11566 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/init-core-data-001
[junit4] 2> 925454 INFO (SUITE-TestReplicationHandler-seed#[C8D4A8F29FD47336]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 925456 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 925456 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1
[junit4] 2> 925460 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 925461 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1a991f6{/solr,null,AVAILABLE}
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1516789{HTTP/1.1,[http/1.1]}{127.0.0.1:34528}
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @926872ms
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=34528}
[junit4] 2> 925463 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 925463 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:04.319Z
[junit4] 2> 925464 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/solr.xml
[junit4] 2> 925469 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 925471 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/.
[junit4] 2> 925471 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 925481 WARN (coreLoadExecutor-7598-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 925482 INFO (coreLoadExecutor-7598-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 925491 INFO (coreLoadExecutor-7598-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 925493 INFO (coreLoadExecutor-7598-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 925495 INFO (coreLoadExecutor-7598-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1
[junit4] 2> 925495 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1/data/]
[junit4] 2> 925496 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 925504 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 925504 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 925505 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 925505 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@10a31f0[collection1] main]
[junit4] 2> 925505 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1/conf
[junit4] 2> 925505 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 925505 INFO (coreLoadExecutor-7598-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 925506 INFO (searcherExecutor-7599-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@10a31f0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 925973 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1
[junit4] 2> 925976 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 925978 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@e44b03{/solr,null,AVAILABLE}
[junit4] 2> 925979 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1ea851a{HTTP/1.1,[http/1.1]}{127.0.0.1:39697}
[junit4] 2> 925979 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @927389ms
[junit4] 2> 925980 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=39697}
[junit4] 2> 925980 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 925980 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 925980 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 925980 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 925980 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:04.836Z
[junit4] 2> 925981 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/solr.xml
[junit4] 2> 925998 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 926000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/.
[junit4] 2> 926000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 926010 WARN (coreLoadExecutor-7608-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 926011 INFO (coreLoadExecutor-7608-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 926022 INFO (coreLoadExecutor-7608-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 926024 INFO (coreLoadExecutor-7608-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 926026 INFO (coreLoadExecutor-7608-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/./collection1
[junit4] 2> 926027 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/./collection1/data/]
[junit4] 2> 926028 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 926034 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 926034 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 926035 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 926035 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@17ce250[collection1] main]
[junit4] 2> 926035 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1/conf
[junit4] 2> 926037 INFO (coreLoadExecutor-7608-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 926037 INFO (searcherExecutor-7609-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@17ce250[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 926039 INFO (qtp7943204-77027) [ 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> 926040 INFO (indexFetcher-7613-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 926040 INFO (indexFetcher-7613-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 926040 INFO (indexFetcher-7613-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 926502 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1ea851a{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 926502 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2336012
[junit4] 2> 926502 INFO (coreCloseExecutor-7614-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@fa8147
[junit4] 2> 926504 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@e44b03{/solr,null,UNAVAILABLE}
[junit4] 2> 926510 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1516789{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 926510 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=18529291
[junit4] 2> 926511 INFO (coreCloseExecutor-7616-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@592ab6
[junit4] 2> 926512 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1a991f6{/solr,null,UNAVAILABLE}
[junit4] 2> 926513 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 926514 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1481290{/solr,null,AVAILABLE}
[junit4] 2> 926514 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@17d85b3{HTTP/1.1,[http/1.1]}{127.0.0.1:41988}
[junit4] 2> 926514 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @927924ms
[junit4] 2> 926514 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=41988}
[junit4] 2> 926515 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 926515 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 926515 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 926515 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 926515 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:05.371Z
[junit4] 2> 926516 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/solr.xml
[junit4] 2> 926524 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 926526 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/.
[junit4] 2> 926526 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 926535 WARN (coreLoadExecutor-7623-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 926536 INFO (coreLoadExecutor-7623-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 926545 INFO (coreLoadExecutor-7623-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 926547 INFO (coreLoadExecutor-7623-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 926547 INFO (coreLoadExecutor-7623-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1
[junit4] 2> 926548 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1/data/]
[junit4] 2> 926549 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 926556 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 926556 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 926556 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 926557 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2cb030[collection1] main]
[junit4] 2> 926557 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1/conf
[junit4] 2> 926557 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 926557 INFO (coreLoadExecutor-7623-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 926557 INFO (searcherExecutor-7624-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2cb030[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927029 INFO (qtp6254532-77065) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 927029 INFO (qtp6254532-77065) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 1
[junit4] 2> 927031 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 927031 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@da6d86
[junit4] 2> 927032 INFO (qtp6254532-77066) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@12085d6[collection1] main]
[junit4] 2> 927033 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 927033 INFO (searcherExecutor-7624-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@12085d6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927033 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
[junit4] 2> 927035 INFO (qtp6254532-77067) [ 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> 927039 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 927040 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 927042 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2c533b{/solr,null,AVAILABLE}
[junit4] 2> 927043 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@8fed62{HTTP/1.1,[http/1.1]}{127.0.0.1:46450}
[junit4] 2> 927043 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @928452ms
[junit4] 2> 927043 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=46450}
[junit4] 2> 927043 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 927044 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 927044 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 927044 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 927044 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:05.900Z
[junit4] 2> 927045 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/solr.xml
[junit4] 2> 927054 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 927055 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/.
[junit4] 2> 927056 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 927086 WARN (coreLoadExecutor-7633-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 927087 INFO (coreLoadExecutor-7633-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 927099 INFO (coreLoadExecutor-7633-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 927101 INFO (coreLoadExecutor-7633-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 927101 INFO (coreLoadExecutor-7633-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/./collection1
[junit4] 2> 927102 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/./collection1/data/]
[junit4] 2> 927103 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 927111 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 927111 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 927111 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 927111 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f331[collection1] main]
[junit4] 2> 927112 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-002/collection1/conf
[junit4] 2> 927112 INFO (coreLoadExecutor-7633-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 927113 INFO (searcherExecutor-7634-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2f331[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927114 INFO (qtp6254532-77065) [ 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> 927114 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 927115 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1478791685887
[junit4] 2> 927115 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 927115 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 927119 INFO (qtp6254532-77066) [ 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> 927119 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 1
[junit4] 2> 927120 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=22, maxMergeAtOnceExplicit=42, maxMergedSegmentMB=30.7587890625, floorSegmentMB=1.9677734375, forceMergeDeletesPctAllowed=12.785975268641947, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 927121 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 927121 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@128b3a7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17c1d56)
[junit4] 2> 927123 INFO (qtp6254532-77067) [ 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> 927124 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=100) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@128b3a7 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@17c1d56)
[junit4] 2> 927125 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=14, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 927125 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 927126 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1c69c37[collection1] main]
[junit4] 2> 927126 INFO (searcherExecutor-7634-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1c69c37[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927558 INFO (qtp29065556-77083) [ 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> 927559 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 927561 INFO (qtp6254532-77060) [ 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> 927564 INFO (qtp6254532-77065) [ 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> 927580 WARN (qtp6254532-77067) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 927581 INFO (qtp6254532-77067) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 927595 INFO (qtp6254532-77067) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 927599 INFO (qtp6254532-77067) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 927600 INFO (qtp6254532-77067) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1
[junit4] 2> 927601 INFO (qtp6254532-77067) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/./collection1/data/]
[junit4] 2> 927612 INFO (qtp6254532-77067) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 927612 INFO (qtp6254532-77067) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 927613 INFO (qtp6254532-77067) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6bb25e[collection1] main]
[junit4] 2> 927613 INFO (qtp6254532-77067) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-001/collection1/conf
[junit4] 2> 927613 INFO (qtp6254532-77067) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 927613 INFO (qtp6254532-77067) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 927614 INFO (searcherExecutor-7640-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6bb25e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927615 INFO (qtp6254532-77067) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=25, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 927616 INFO (qtp6254532-77067) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 927616 INFO (qtp6254532-77067) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@70ea5c[collection1] main]
[junit4] 2> 927616 INFO (qtp6254532-77067) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@e92c20
[junit4] 2> 927616 INFO (searcherExecutor-7640-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@70ea5c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 927617 INFO (qtp6254532-77067) [ 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=49
[junit4] 2> 927619 INFO (qtp6254532-77066) [ 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> 927621 INFO (qtp6254532-77062) [ 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> 927624 INFO (qtp6254532-77067) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 927626 INFO (qtp6254532-77060) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 927628 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 927628 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@2a5dff
[junit4] 2> 927635 INFO (qtp6254532-77066) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1fd8bad[collection1] main]
[junit4] 2> 927635 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 927635 INFO (searcherExecutor-7640-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1fd8bad[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c2)))}
[junit4] 2> 927635 INFO (qtp6254532-77066) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 7
[junit4] 2> 927638 INFO (qtp6254532-77062) [ 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=1
[junit4] 2> 927639 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
[junit4] 2> 927641 INFO (qtp29065556-77084) [ 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> 927641 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 927743 INFO (qtp29065556-77085) [ 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> 927744 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 927846 INFO (qtp29065556-77079) [ 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> 927846 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 927948 INFO (qtp29065556-77083) [ 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> 927949 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 928051 INFO (qtp29065556-77084) [ 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> 928051 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 928114 INFO (qtp6254532-77061) [ 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> 928114 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 928114 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1478791686484
[junit4] 2> 928114 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 928115 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 928117 INFO (qtp6254532-77060) [ 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=0
[junit4] 2> 928118 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
[junit4] 2> 928118 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=43, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.19175759309964793]
[junit4] 2> 928119 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 928119 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@154ada4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60e2d3)
[junit4] 2> 928120 INFO (qtp6254532-77066) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 928124 INFO (qtp6254532-77062) [ 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> 928126 INFO (qtp6254532-77061) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 928129 INFO (qtp6254532-77061) [ 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> 928129 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1899) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@154ada4 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60e2d3)
[junit4] 2> 928130 WARN (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Exception while updating statistics
[junit4] 2> java.io.IOException: file "replication.properties" was already written to
[junit4] 2> at org.apache.lucene.store.MockDirectoryWrapper.createOutput(MockDirectoryWrapper.java:654)
[junit4] 2> at org.apache.solr.handler.IndexFetcher.logReplicationTimeAndConfFiles(IndexFetcher.java:675)
[junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:487)
[junit4] 2> at org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:251)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$2(ReplicationHandler.java:1147)
[junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 928131 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1101479779, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 928132 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 928133 INFO (indexFetcher-7638-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@c3b7a4[collection1] main]
[junit4] 2> 928133 INFO (searcherExecutor-7634-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c3b7a4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c2)))}
[junit4] 2> 928153 INFO (qtp29065556-77085) [ 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> 928154 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waited for 500ms and found 2 docs
[junit4] 2> 928154 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 928155 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@17d85b3{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 928155 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=22769845
[junit4] 2> 928155 INFO (coreCloseExecutor-7645-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1e90d85
[junit4] 2> 928157 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1481290{/solr,null,UNAVAILABLE}
[junit4] 2> 928158 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@8fed62{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 928158 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1396737
[junit4] 2> 928158 INFO (coreCloseExecutor-7647-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1e3f9b2
[junit4] 2> 928159 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2c533b{/solr,null,UNAVAILABLE}
[junit4] 2> 928164 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestStressReplication
[junit4] 2> 928164 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1
[junit4] 2> 928167 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 928168 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d10930{/solr,null,AVAILABLE}
[junit4] 2> 928168 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@1e71585{HTTP/1.1,[http/1.1]}{127.0.0.1:38794}
[junit4] 2> 928168 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @929578ms
[junit4] 2> 928168 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=38794}
[junit4] 2> 928169 ERROR (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 928169 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 928169 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 928169 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 928169 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:07.025Z
[junit4] 2> 928169 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/solr.xml
[junit4] 2> 928176 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 928178 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/.
[junit4] 2> 928178 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 928203 WARN (coreLoadExecutor-7654-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 928203 INFO (coreLoadExecutor-7654-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 928212 INFO (coreLoadExecutor-7654-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 928214 INFO (coreLoadExecutor-7654-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 928215 INFO (coreLoadExecutor-7654-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/./collection1
[junit4] 2> 928215 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/./collection1/data/]
[junit4] 2> 928216 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 928223 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 928223 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 928223 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 928223 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@185216b[collection1] main]
[junit4] 2> 928224 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1/conf
[junit4] 2> 928224 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 928224 INFO (coreLoadExecutor-7654-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 928224 INFO (searcherExecutor-7655-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@185216b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 928695 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1
[junit4] 2> 928698 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 928699 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@59e371{/solr,null,AVAILABLE}
[junit4] 2> 928700 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@cfa757{HTTP/1.1,[http/1.1]}{127.0.0.1:43564}
[junit4] 2> 928700 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @930110ms
[junit4] 2> 928700 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=43564}
[junit4] 2> 928700 ERROR (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 928701 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 928701 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 928701 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 928701 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:07.557Z
[junit4] 2> 928702 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/solr.xml
[junit4] 2> 928709 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 928712 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/.
[junit4] 2> 928712 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 928721 WARN (coreLoadExecutor-7664-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 928722 INFO (coreLoadExecutor-7664-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 928731 INFO (coreLoadExecutor-7664-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 928734 INFO (coreLoadExecutor-7664-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 928735 INFO (coreLoadExecutor-7664-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/./collection1
[junit4] 2> 928736 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/./collection1/data/]
[junit4] 2> 928738 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 928747 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 928747 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 928748 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 928748 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@18ea761[collection1] main]
[junit4] 2> 928748 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1/conf
[junit4] 2> 928750 INFO (coreLoadExecutor-7664-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 928751 INFO (searcherExecutor-7665-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@18ea761[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 928752 INFO (qtp24568656-77108) [ 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> 928753 INFO (indexFetcher-7669-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 928753 INFO (indexFetcher-7669-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 928753 INFO (indexFetcher-7669-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 929228 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@cfa757{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 929228 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2476645
[junit4] 2> 929229 INFO (coreCloseExecutor-7670-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1270cca
[junit4] 2> 929231 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@59e371{/solr,null,UNAVAILABLE}
[junit4] 2> 929232 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 929233 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1545ba9{/solr,null,AVAILABLE}
[junit4] 2> 929233 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@8ed8ce{HTTP/1.1,[http/1.1]}{127.0.0.1:36789}
[junit4] 2> 929233 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @930643ms
[junit4] 2> 929234 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=36789}
[junit4] 2> 929234 ERROR (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 929234 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 929234 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 929234 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 929234 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:08.090Z
[junit4] 2> 929235 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/solr.xml
[junit4] 2> 929241 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 929243 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/.
[junit4] 2> 929243 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 929263 WARN (coreLoadExecutor-7677-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 929264 INFO (coreLoadExecutor-7677-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 929272 INFO (coreLoadExecutor-7677-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 929274 INFO (coreLoadExecutor-7677-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 929275 INFO (coreLoadExecutor-7677-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/./collection1
[junit4] 2> 929275 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/./collection1/data/]
[junit4] 2> 929276 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 929284 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 929284 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 929284 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 929284 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b822af[collection1] main]
[junit4] 2> 929285 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-004/collection1/conf
[junit4] 2> 929285 INFO (coreLoadExecutor-7677-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 929285 INFO (searcherExecutor-7678-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@b822af[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 929749 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1e71585{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 929749 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=29644635
[junit4] 2> 929749 INFO (coreCloseExecutor-7682-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@16aac9
[junit4] 2> 929751 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d10930{/solr,null,UNAVAILABLE}
[junit4] 2> 929752 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 929753 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1bd8269{/solr,null,AVAILABLE}
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Started ServerConnector@4afe1c{HTTP/1.1,[http/1.1]}{127.0.0.1:40065}
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.Server Started @931163ms
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=40065}
[junit4] 2> 929754 ERROR (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 6.4.0
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 929754 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2016-11-10T15:28:08.610Z
[junit4] 2> 929755 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/solr.xml
[junit4] 2> 929762 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 929763 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/.
[junit4] 2> 929763 INFO (TEST-TestReplicationHandler.doTestStressReplication-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 929773 WARN (coreLoadExecutor-7689-thread-1) [ ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 929774 INFO (coreLoadExecutor-7689-thread-1) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 929784 INFO (coreLoadExecutor-7689-thread-1) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 929786 INFO (coreLoadExecutor-7689-thread-1) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 929787 INFO (coreLoadExecutor-7689-thread-1) [ ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/./collection1
[junit4] 2> 929787 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/./collection1/data/]
[junit4] 2> 929788 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=43, maxMergedSegmentMB=47.173828125, floorSegmentMB=1.677734375, forceMergeDeletesPctAllowed=27.115450792945396, segmentsPerTier=32.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 929796 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 929796 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 929797 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=35, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 929797 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d71d8[collection1] main]
[junit4] 2> 929798 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001/solr-instance-003/collection1/conf
[junit4] 2> 929798 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 929798 INFO (coreLoadExecutor-7689-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 929798 INFO (searcherExecutor-7690-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5d71d8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 930266 INFO (qtp28967040-77163) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 930267 INFO (qtp28967040-77163) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 1
[junit4] 2> 930269 INFO (qtp3005771-77145) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 930269 INFO (qtp3005771-77145) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
[junit4] 2> 930271 INFO (qtp3005771-77146) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 930271 INFO (qtp3005771-77146) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1c682fe
[junit4] 2> 930273 INFO (qtp3005771-77146) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@3c76cd[collection1] main]
[junit4] 2> 930273 INFO (qtp3005771-77146) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 930273 INFO (searcherExecutor-7678-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@3c76cd[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 930274 INFO (qtp3005771-77146) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 2
[junit4] 2> 930277 INFO (qtp28967040-77164) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 1
[junit4] 2> 930280 INFO (qtp28967040-77165) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 930282 INFO (qtp28967040-77158) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 930284 INFO (qtp28967040-77163) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
[junit4] 2> 930286 INFO (qtp28967040-77164) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
[junit4] 2> 930288 INFO (qtp28967040-77165) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
[...truncated too long message...]
date.SolrIndexWriter@4bd9d9
[junit4] 2> 1049540 INFO (qtp2843668-78013) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@a7b4e4[collection1] main]
[junit4] 2> 1049541 INFO (qtp2843668-78013) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1049541 INFO (searcherExecutor-8240-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a7b4e4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1) Uninverting(_1(6.4.0):c1) Uninverting(_2(6.4.0):c1)))}
[junit4] 2> 1049541 INFO (qtp2843668-78013) [ 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> 1049545 INFO (qtp2843668-78018) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[554]} 0 0
[junit4] 2> 1049547 INFO (qtp2843668-78014) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1049547 INFO (qtp2843668-78014) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4bd9d9
[junit4] 2> 1049550 INFO (qtp2843668-78014) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1ef7ab1[collection1] main]
[junit4] 2> 1049551 INFO (qtp2843668-78014) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1049551 INFO (searcherExecutor-8240-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1ef7ab1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1) Uninverting(_1(6.4.0):c1) Uninverting(_2(6.4.0):c1) Uninverting(_3(6.4.0):c1)))}
[junit4] 2> 1049551 INFO (qtp2843668-78014) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
[junit4] 2> 1049553 INFO (qtp2843668-78020) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[555]} 0 0
[junit4] 2> 1049557 INFO (qtp2843668-78013) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1049557 INFO (qtp2843668-78013) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@4bd9d9
[junit4] 2> 1049560 INFO (qtp2843668-78013) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f15af9[collection1] main]
[junit4] 2> 1049561 INFO (searcherExecutor-8240-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f15af9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):c1) Uninverting(_1(6.4.0):c1) Uninverting(_2(6.4.0):c1) Uninverting(_3(6.4.0):c1) Uninverting(_4(6.4.0):c1)))}
[junit4] 2> 1049561 INFO (qtp2843668-78013) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1049561 INFO (qtp2843668-78013) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 4
[junit4] 2> 1049564 INFO (qtp2843668-78018) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=id:555&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 2> 1049564 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
[junit4] 2> 1049567 INFO (qtp13038065-78001) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=enablereplication} status=0 QTime=0
[junit4] 2> 1049568 INFO (qtp2843668-78019) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={command=fetchindex} status=0 QTime=0
[junit4] 2> 1049568 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterWrite2Slave
[junit4] 2> 1049569 ERROR (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master at: http://127.0.0.1:37362/solr/collection1 is not available. Index fetch failed. Exception: Server refused connection at: http://127.0.0.1:37362/solr/collection1
[junit4] 2> 1049570 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@1678aca{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1049570 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=23682917
[junit4] 2> 1049571 INFO (coreCloseExecutor-8245-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@767aff
[junit4] 2> 1049572 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@193343{/solr,null,UNAVAILABLE}
[junit4] 2> 1049573 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.ServerConnector Stopped ServerConnector@13c45fc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 1049573 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=19362362
[junit4] 2> 1049574 INFO (coreCloseExecutor-8247-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1f9f07f
[junit4] 2> 1049575 INFO (TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[C8D4A8F29FD47336]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1faaf1f{/solr,null,UNAVAILABLE}
[junit4] 2> 1049578 INFO (SUITE-TestReplicationHandler-seed#[C8D4A8F29FD47336]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-6.x-Linux/solr/build/solr-core/test/J2/temp/solr.handler.TestReplicationHandler_C8D4A8F29FD47336-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {name=PostingsFormat(name=Direct), id=PostingsFormat(name=Direct), newname=PostingsFormat(name=Direct)}, docValues:{}, maxPointsInLeafNode=1496, maxMBSortInHeap=6.2785975268641945, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=es-DO, timezone=Europe/Stockholm
[junit4] 2> NOTE: Linux 4.4.0-42-generic i386/Oracle Corporation 1.8.0_102 (32-bit)/cpus=12,threads=1,free=177999344,total=387170304
[junit4] 2> NOTE: All tests run in this JVM: [ChangedSchemaMergeTest, ConnectionReuseTest, FullSolrCloudDistribCmdsTest, HdfsSyncSliceTest, DistributedDebugComponentTest, TestMacroExpander, BigEndianAscendingWordDeserializerTest, HardAutoCommitTest, WrapperMergePolicyFactoryTest, SortSpecParsingTest, TestCollationFieldDocValues, TestStressLiveNodes, TestFieldResource, OverseerTest, TestCoreDiscovery, CdcrRequestHandlerTest, DOMUtilTest, PluginInfoTest, TestReplicaProperties, TestMergePolicyConfig, TestLeaderElectionWithEmptyReplica, DeleteReplicaTest, TestPushWriter, SolrPluginUtilsTest, TestConfig, TimeZoneUtilsTest, TestTolerantSearch, TestMissingGroups, TestStressUserVersions, TestSolr4Spatial2, ParsingFieldUpdateProcessorsTest, TestConfigSets, RequestLoggingTest, TestDocTermOrds, TestPhraseSuggestions, TestLMJelinekMercerSimilarityFactory, DistributedFacetPivotSmallTest, TestPKIAuthenticationPlugin, PeerSyncReplicationTest, HdfsUnloadDistributedZkTest, BadIndexSchemaTest, TestHighFrequencyDictionaryFactory, HdfsDirectoryFactoryTest, SmileWriterTest, TestReRankQParserPlugin, TestLocalFSCloudBackupRestore, TestFieldCacheSanityChecker, TestReload, SuggesterTest, TestSolrQueryResponse, XmlUpdateRequestHandlerTest, TestExactSharedStatsCache, SimpleCollectionCreateDeleteTest, TestStressReorder, EnumFieldTest, LukeRequestHandlerTest, StatsComponentTest, TestAnalyzedSuggestions, SmileWriterTest, TestXIncludeConfig, UnloadDistributedZkTest, TestZkChroot, TestJmxMonitoredMap, JavabinLoaderTest, TestClusterStateMutator, BJQParserTest, TestCollapseQParserPlugin, TestNamedUpdateProcessors, TestBinaryField, TestWriterPerf, TestSolrDeletionPolicy1, PrimUtilsTest, DistributedFacetPivotLargeTest, CursorMarkTest, StatelessScriptUpdateProcessorFactoryTest, RollingRestartTest, SecurityConfHandlerTest, TestSolrConfigHandlerCloud, ShowFileRequestHandlerTest, BinaryUpdateRequestHandlerTest, TestExpandComponent, FieldMutatingUpdateProcessorTest, TestSort, TestConfigSetsAPI, TestManagedSchemaThreadSafety, TestUseDocValuesAsStored2, MinimalSchemaTest, TestCollationField, SolrCoreCheckLockOnStartupTest, TestSolrQueryParser, SolrXmlInZkTest, SimpleMLTQParserTest, TestDownShardTolerantSearch, NoCacheHeaderTest, SolrTestCaseJ4Test, FieldAnalysisRequestHandlerTest, JSONWriterTest, DebugComponentTest, TestSolrQueryParserResource, CleanupOldIndexTest, BasicDistributedZk2Test, TestCloudInspectUtil, TestIndexingPerformance, BasicDistributedZkTest, RecoveryZkTest, TestReplicationHandler]
[junit4] Completed [267/651 (1!)] on J2 in 124.15s, 15 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 54227 lines...]