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 2017/01/09 09:49:06 UTC
[JENKINS] Lucene-Solr-6.x-MacOSX (64bit/jdk1.8.0) - Build # 632 -
Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-6.x-MacOSX/632/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -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([A76B92EAD53F91C9:50187CB213D73E2F]: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:1347)
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 11757 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/init-core-data-001
[junit4] 2> 1656173 INFO (SUITE-TestReplicationHandler-seed#[A76B92EAD53F91C9]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 1656175 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
[junit4] 2> 1656175 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/collection1
[junit4] 2> 1656184 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1656186 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1cb61c11{/solr,null,AVAILABLE}
[junit4] 2> 1656186 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4e09a984{HTTP/1.1,[http/1.1]}{127.0.0.1:६४७७४}
[junit4] 2> 1656187 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server Started @१६६९८४५ms
[junit4] 2> 1656187 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=64774}
[junit4] 2> 1656187 ERROR (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1656188 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1656188 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1656188 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1656188 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-09T08:52:35.596Z
[junit4] 2> 1656189 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/solr.xml
[junit4] 2> 1656205 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1656213 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/.
[junit4] 2> 1656213 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1656236 WARN (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1656237 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1656248 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1656253 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1656257 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/./collection1
[junit4] 2> 1656258 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/./collection1/data/]
[junit4] 2> 1656259 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=9.78515625, floorSegmentMB=1.0078125, forceMergeDeletesPctAllowed=8.42751490474457, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23494825197180358
[junit4] 2> 1656277 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1656277 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1656278 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1656279 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@71d3ae79[collection1] main]
[junit4] 2> 1656279 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-001/collection1/conf
[junit4] 2> 1656280 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1656280 INFO (coreLoadExecutor-5780-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1656280 INFO (searcherExecutor-5781-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@71d3ae79[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1657040 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/collection1
[junit4] 2> 1657045 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1657048 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@58a0b3d{/solr,null,AVAILABLE}
[junit4] 2> 1657048 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@42424339{HTTP/1.1,[http/1.1]}{127.0.0.1:६४७७५}
[junit4] 2> 1657048 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server Started @१६७०७०६ms
[junit4] 2> 1657048 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=64775}
[junit4] 2> 1657049 ERROR (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1657049 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1657049 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1657050 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1657050 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-09T08:52:36.458Z
[junit4] 2> 1657050 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/solr.xml
[junit4] 2> 1657057 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1657065 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/.
[junit4] 2> 1657065 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1657076 WARN (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1657077 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1657087 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1657090 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1657092 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/./collection1
[junit4] 2> 1657092 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/./collection1/data/]
[junit4] 2> 1657095 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=9.78515625, floorSegmentMB=1.0078125, forceMergeDeletesPctAllowed=8.42751490474457, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23494825197180358
[junit4] 2> 1657118 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1657118 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1657127 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1657151 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@311b6863[collection1] main]
[junit4] 2> 1657151 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-002/collection1/conf
[junit4] 2> 1657155 INFO (coreLoadExecutor-5790-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1657155 INFO (searcherExecutor-5791-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@311b6863[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1657160 INFO (qtp2124696920-13258) [ 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> 1657160 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1657160 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1657160 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1657981 INFO (qtp2124696920-13260) [ 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> 1657985 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1657991 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1657992 INFO (qtp1426845294-13275) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3
[junit4] 2> 1657995 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
[junit4] 2> 1657997 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1657997 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3396207e
[junit4] 2> 1658002 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@73619ca6[collection1] main]
[junit4] 2> 1658002 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1658003 INFO (searcherExecutor-5781-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@73619ca6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1)))}
[junit4] 2> 1658003 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 5
[junit4] 2> 1658010 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1658014 INFO (qtp2124696920-13258) [ 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> 1658014 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 1658014 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951957405
[junit4] 2> 1658014 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1658014 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1658022 INFO (qtp2124696920-13259) [ 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=5
[junit4] 2> 1658022 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 8
[junit4] 2> 1658032 INFO (explicit-fetchindex-cmd) [ 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=0.5890267681016564]
[junit4] 2> 1658033 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658033 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@633256dd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@787bcdd4))
[junit4] 2> 1658035 INFO (qtp2124696920-13260) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658039 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658042 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658045 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Memory_0.ram&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658048 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658051 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658054 INFO (qtp2124696920-13259) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658058 INFO (qtp2124696920-13260) [ 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> 1658058 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1269) : 0 secs (null bytes/sec) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@633256dd lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@787bcdd4))
[junit4] 2> 1658063 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=28.0908203125, floorSegmentMB=0.8017578125, forceMergeDeletesPctAllowed=12.73638595779812, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1658066 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658068 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5cdf2906[collection1] main]
[junit4] 2> 1658068 INFO (searcherExecutor-5791-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5cdf2906[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1)))}
[junit4] 2> 1658069 INFO (qtp1426845294-13276) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:64774/solr/collection1/replication&command=fetchindex} status=0 QTime=61
[junit4] 2> 1658076 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1658076 INFO (qtp1426845294-13278) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3
[junit4] 2> 1658079 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 1658081 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1658081 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3396207e
[junit4] 2> 1658104 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5d448280[collection1] main]
[junit4] 2> 1658104 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1658104 INFO (searcherExecutor-5781-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5d448280[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1) Uninverting(_1(6.4.0):C1)))}
[junit4] 2> 1658104 INFO (qtp2124696920-13263) [ 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 23
[junit4] 2> 1658106 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1658109 INFO (qtp2124696920-13258) [ 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> 1658110 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 1658110 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951957489
[junit4] 2> 1658110 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 1658110 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1658121 INFO (qtp2124696920-13256) [ 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=8
[junit4] 2> 1658121 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 15
[junit4] 2> 1658123 INFO (explicit-fetchindex-cmd) [ 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=0.5890267681016564]
[junit4] 2> 1658125 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658126 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@d9783c5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42fa3991))
[junit4] 2> 1658126 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 1658126 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 1658127 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 1658127 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Memory_0.ram because it already exists
[junit4] 2> 1658128 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 1658128 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 1658128 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 1658130 INFO (qtp2124696920-13259) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658134 INFO (qtp2124696920-13260) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658138 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1_Memory_0.ram&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658144 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658147 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658151 INFO (qtp2124696920-13258) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658156 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&file=_1.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658158 INFO (qtp2124696920-13259) [ 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> 1658160 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1332) : 0 secs (null bytes/sec) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@d9783c5 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@42fa3991))
[junit4] 2> 1658176 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=28.0908203125, floorSegmentMB=0.8017578125, forceMergeDeletesPctAllowed=12.73638595779812, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1658181 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658184 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7bd1e9b4[collection1] main]
[junit4] 2> 1658184 INFO (searcherExecutor-5791-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7bd1e9b4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1) Uninverting(_1(6.4.0):C1)))}
[junit4] 2> 1658184 INFO (qtp1426845294-13279) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:64774/solr/collection1/replication&command=fetchindex} status=0 QTime=78
[junit4] 2> 1658190 INFO (qtp2124696920-13260) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1658190 INFO (qtp1426845294-13280) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=3
[junit4] 2> 1658192 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
[junit4] 2> 1658194 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1658194 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3396207e
[junit4] 2> 1658199 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@dd925d3[collection1] main]
[junit4] 2> 1658199 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1658200 INFO (searcherExecutor-5781-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@dd925d3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1) Uninverting(_1(6.4.0):C1) Uninverting(_2(6.4.0):C1)))}
[junit4] 2> 1658200 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 5
[junit4] 2> 1658201 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1658204 INFO (qtp2124696920-13263) [ 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> 1658205 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 1658205 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951957602
[junit4] 2> 1658205 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 3
[junit4] 2> 1658205 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1658209 INFO (qtp2124696920-13258) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=3
[junit4] 2> 1658210 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 22
[junit4] 2> 1658211 INFO (explicit-fetchindex-cmd) [ 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=0.5890267681016564]
[junit4] 2> 1658213 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658214 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@d5a20b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4c6bbae1))
[junit4] 2> 1658214 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.si because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvd because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdx because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0_Memory_0.ram because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fdt because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.fnm because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _0.nvm because it already exists
[junit4] 2> 1658215 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.si because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvd because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1_Memory_0.ram because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdx because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fnm because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.nvm because it already exists
[junit4] 2> 1658216 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Skipping download for _1.fdt because it already exists
[junit4] 2> 1658219 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658222 INFO (qtp2124696920-13259) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658231 INFO (qtp2124696920-13260) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658233 INFO (qtp2124696920-13261) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658236 INFO (qtp2124696920-13262) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658238 INFO (qtp2124696920-13263) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2_Memory_0.ram&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658241 INFO (qtp2124696920-13258) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=_2.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658244 INFO (qtp2124696920-13256) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=4&qt=/replication&file=segments_4&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1658245 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1395) : 0 secs (null bytes/sec) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@d5a20b8 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4c6bbae1))
[junit4] 2> 1658247 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=28.0908203125, floorSegmentMB=0.8017578125, forceMergeDeletesPctAllowed=12.73638595779812, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1658251 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1658254 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a72213e[collection1] main]
[junit4] 2> 1658254 INFO (searcherExecutor-5791-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a72213e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1) Uninverting(_1(6.4.0):C1) Uninverting(_2(6.4.0):C1)))}
[junit4] 2> 1658254 INFO (qtp1426845294-13273) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:64774/solr/collection1/replication&command=fetchindex} status=0 QTime=53
[junit4] 2> 1658256 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/collection1
[junit4] 2> 1658264 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1658266 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@2b52e951{/solr,null,AVAILABLE}
[junit4] 2> 1658267 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@19dfb0fa{HTTP/1.1,[http/1.1]}{127.0.0.1:६४७८४}
[junit4] 2> 1658267 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server Started @१६७१९२४ms
[junit4] 2> 1658267 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=64784}
[junit4] 2> 1658267 ERROR (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1658268 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1658268 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1658268 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1658268 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-09T08:52:37.676Z
[junit4] 2> 1658269 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/solr.xml
[junit4] 2> 1658275 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1658280 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/.
[junit4] 2> 1658281 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1658298 WARN (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1658300 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1658309 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1658312 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1658313 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/./collection1
[junit4] 2> 1658313 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/./collection1/data/]
[junit4] 2> 1658337 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=9.78515625, floorSegmentMB=1.0078125, forceMergeDeletesPctAllowed=8.42751490474457, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23494825197180358
[junit4] 2> 1658407 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1658407 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1658417 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1658449 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@567b56ff[collection1] main]
[junit4] 2> 1658449 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-003/collection1/conf
[junit4] 2> 1658450 WARN (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1658452 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler No value set for 'pollInterval'. Timer Task not started.
[junit4] 2> 1658452 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 1658452 INFO (coreLoadExecutor-5804-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1658452 INFO (searcherExecutor-5805-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@567b56ff[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1659161 INFO (qtp2124696920-13259) [ 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> 1659161 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 4
[junit4] 2> 1659161 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951957602
[junit4] 2> 1659161 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 4
[junit4] 2> 1659161 INFO (indexFetcher-5795-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 1659163 WARN (qtp1105222228-13302) [ x:collection1] o.a.s.h.ReplicationHandler Exception while invoking 'details' method for replication on master
[junit4] 2> org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:64774/solr: Expected mime type application/octet-stream but got text/html. <html>
[junit4] 2> <head>
[junit4] 2> <meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
[junit4] 2> <title>Error 404 </title>
[junit4] 2> </head>
[junit4] 2> <body>
[junit4] 2> <h2>HTTP ERROR: 404</h2>
[junit4] 2> <p>Problem accessing /solr/replication. Reason:
[junit4] 2> <pre> Can not find: /solr/replication</pre></p>
[junit4] 2> <hr /><a href="http://eclipse.org/jetty">Powered by Jetty:// 9.3.14.v20161028</a><hr/>
[junit4] 2> </body>
[junit4] 2> </html>
[junit4] 2>
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:578)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
[junit4] 2> at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
[junit4] 2> at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at org.apache.solr.handler.IndexFetcher.getDetails(IndexFetcher.java:1716)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.getReplicationDetails(ReplicationHandler.java:915)
[junit4] 2> at org.apache.solr.handler.ReplicationHandler.handleRequestBody(ReplicationHandler.java:312)
[junit4] 2> at org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:166)
[junit4] 2> at org.apache.solr.core.SolrCore.execute(SolrCore.java:2306)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:658)
[junit4] 2> at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:464)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:345)
[junit4] 2> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:296)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:462)
[junit4] 2> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 1659164 INFO (qtp1105222228-13302) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1659166 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@19dfb0fa{HTTP/1.1,[http/1.1]}{127.0.0.1:०}
[junit4] 2> 1659166 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=743275854
[junit4] 2> 1659167 INFO (coreCloseExecutor-5809-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@f97f524
[junit4] 2> 1659169 INFO (coreCloseExecutor-5809-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1659170 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1659170 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2b52e951{/solr,null,UNAVAILABLE}
[junit4] 2> 1659173 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestDetails
[junit4] 2> 1659173 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@4e09a984{HTTP/1.1,[http/1.1]}{127.0.0.1:०}
[junit4] 2> 1659174 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=988951661
[junit4] 2> 1659175 INFO (coreCloseExecutor-5811-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2aca420a
[junit4] 2> 1659176 INFO (coreCloseExecutor-5811-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1659176 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1659177 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1cb61c11{/solr,null,UNAVAILABLE}
[junit4] 2> 1659179 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@42424339{HTTP/1.1,[http/1.1]}{127.0.0.1:०}
[junit4] 2> 1659179 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=501675961
[junit4] 2> 1659180 INFO (coreCloseExecutor-5813-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@20dd010b
[junit4] 2> 1659181 INFO (coreCloseExecutor-5813-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1659186 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1659186 INFO (TEST-TestReplicationHandler.doTestDetails-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@58a0b3d{/solr,null,UNAVAILABLE}
[junit4] 2> 1659191 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testEmptyCommits
[junit4] 2> 1659192 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/collection1
[junit4] 2> 1659202 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1659205 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4ca2eb58{/solr,null,AVAILABLE}
[junit4] 2> 1659210 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@7e423d0f{HTTP/1.1,[http/1.1]}{127.0.0.1:६४७८७}
[junit4] 2> 1659210 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server Started @१६७२८६८ms
[junit4] 2> 1659210 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=64787}
[junit4] 2> 1659211 ERROR (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1659211 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1659211 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1659211 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1659212 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-09T08:52:38.619Z
[junit4] 2> 1659212 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/solr.xml
[junit4] 2> 1660038 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1660079 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/.
[junit4] 2> 1660079 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1660108 WARN (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1660109 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1660123 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1660132 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1660139 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/./collection1
[junit4] 2> 1660140 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/./collection1/data/]
[junit4] 2> 1660150 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=9.78515625, floorSegmentMB=1.0078125, forceMergeDeletesPctAllowed=8.42751490474457, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23494825197180358
[junit4] 2> 1660173 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1660173 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1660184 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1660208 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5b71896[collection1] main]
[junit4] 2> 1660209 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-004/collection1/conf
[junit4] 2> 1660209 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 1660210 INFO (coreLoadExecutor-5820-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1660210 INFO (searcherExecutor-5821-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5b71896[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1661055 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/collection1
[junit4] 2> 1661063 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 1661065 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5f02267e{/solr,null,AVAILABLE}
[junit4] 2> 1661066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@218ba137{HTTP/1.1,[http/1.1]}{127.0.0.1:६४७९२}
[junit4] 2> 1661066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.Server Started @१६७४७२४ms
[junit4] 2> 1661066 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/collection1/data, hostContext=/solr, hostPort=64792}
[junit4] 2> 1661067 ERROR (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 1661067 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 6.4.0
[junit4] 2> 1661067 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 1661067 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 1661067 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-01-09T08:52:40.475Z
[junit4] 2> 1661068 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/solr.xml
[junit4] 2> 1661076 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 1661081 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/.
[junit4] 2> 1661082 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 1661092 WARN (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 1661093 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.4.0
[junit4] 2> 1661106 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 1661108 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 1661110 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/./collection1
[junit4] 2> 1661110 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/collection1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/./collection1/data/]
[junit4] 2> 1661111 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=23, maxMergeAtOnceExplicit=36, maxMergedSegmentMB=9.78515625, floorSegmentMB=1.0078125, forceMergeDeletesPctAllowed=8.42751490474457, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23494825197180358
[junit4] 2> 1661124 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 1661124 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1661124 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=48, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 1661125 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@22e3133[collection1] main]
[junit4] 2> 1661125 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001/solr-instance-005/collection1/conf
[junit4] 2> 1661126 INFO (coreLoadExecutor-5830-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 1661126 INFO (searcherExecutor-5831-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@22e3133[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1661456 INFO (qtp1767266231-13324) [ 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> 1661456 INFO (indexFetcher-5835-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 1661456 INFO (indexFetcher-5835-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 1661456 INFO (indexFetcher-5835-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1661909 INFO (qtp1767266231-13326) [ 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> 1661912 INFO (qtp1767266231-13327) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
[junit4] 2> 1661915 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1661915 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@641d3574
[junit4] 2> 1661919 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@708635e2[collection1] main]
[junit4] 2> 1661919 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1661919 INFO (searcherExecutor-5821-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@708635e2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1)))}
[junit4] 2> 1661919 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 4
[junit4] 2> 1661922 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1661925 INFO (qtp1767266231-13329) [ 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> 1661926 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 1661926 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951961323
[junit4] 2> 1661926 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 1661926 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 1661932 INFO (qtp1767266231-13322) [ 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> 1661932 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 8
[junit4] 2> 1661933 INFO (explicit-fetchindex-cmd) [ 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=0.5890267681016564]
[junit4] 2> 1661934 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1661934 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@438dd909 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ef740a))
[junit4] 2> 1661936 INFO (qtp1767266231-13324) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661939 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvd&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661944 INFO (qtp1767266231-13326) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdx&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661947 INFO (qtp1767266231-13327) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0_Memory_0.ram&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661949 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fdt&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661956 INFO (qtp1767266231-13329) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.fnm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661961 INFO (qtp1767266231-13322) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.nvm&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 1661964 INFO (qtp1767266231-13324) [ 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> 1661965 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=1263) : 0 secs (null bytes/sec) to MetricsDirectory(MockDirectoryWrapper(RAMDirectory@438dd909 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5ef740a))
[junit4] 2> 1661967 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=40, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=28.0908203125, floorSegmentMB=0.8017578125, forceMergeDeletesPctAllowed=12.73638595779812, segmentsPerTier=27.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 1661968 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 1661969 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@24da3cd9[collection1] main]
[junit4] 2> 1661969 INFO (searcherExecutor-5831-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@24da3cd9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1)))}
[junit4] 2> 1661969 INFO (qtp267056654-13341) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:64787/solr/collection1/replication&command=fetchindex} status=0 QTime=47
[junit4] 2> 1661972 INFO (qtp267056654-13343) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=name:empty1&sort=id+desc&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4] 2> 1661973 INFO (TEST-TestReplicationHandler.testEmptyCommits-seed#[A76B92EAD53F91C9]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 1 docs
[junit4] 2> 1661976 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1661978 INFO (qtp1767266231-13326) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1661985 INFO (qtp1767266231-13327) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1661986 INFO (qtp267056654-13344) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1661988 INFO (qtp1767266231-13328) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1661991 INFO (qtp267056654-13345) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1661996 INFO (qtp1767266231-13329) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1661996 INFO (qtp1767266231-13329) [ x:collection1] o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 1661996 INFO (qtp1767266231-13329) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1661997 INFO (qtp1767266231-13329) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 0
[junit4] 2> 1661998 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
[junit4] 2> 1662002 INFO (qtp1767266231-13322) [ 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> 1662002 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 1662002 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1483951961323
[junit4] 2> 1662002 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 1662002 INFO (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 1662003 INFO (qtp267056654-13346) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:64787/solr/collection1/replication&command=fetchindex} status=0 QTime=4
[junit4] 2> 1662007 INFO (qtp1767266231-13324) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 1
[junit4] 2> 1662011 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 1662011 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@641d3574
[junit4] 2> 1662015 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7fc88a29[collection1] main]
[junit4] 2> 1662015 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 1662015 INFO (searcherExecutor-5821-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7fc88a29[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.4.0):C1) Uninverting(_1(6.4.0):C1)))}
[junit4] 2> 1662015 INFO (qtp1767266231-13325) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={commit=true&wt=javabin&version=2}{commit=} 0 4
[junit4] 2> 1662017 WARN (explicit-fetchindex-cmd) [ x:collection1] o.a.s.h.IndexFetcher 'masterU
[...truncated too long message...]
replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=7
[junit4] 2> 1795906 INFO (qtp1042315678-14283) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1795906 INFO (qtp619554250-14245) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1795913 INFO (qtp619554250-14246) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1795913 INFO (qtp1042315678-14285) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1795916 INFO (qtp619554250-14247) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1795919 INFO (qtp1042315678-14284) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=assertVersions&qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 1795924 INFO (qtp1042315678-14284) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=0
[junit4] 2> 1795925 INFO (qtp619554250-14247) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1795932 INFO (qtp619554250-14242) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={slave=false&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=1
[junit4] 2> 1795932 INFO (qtp1042315678-14281) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={_trace=getDetails&qt=/replication&wt=javabin&version=2&command=details} status=0 QTime=4
[junit4] 2> 1795932 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestIndexFetchWithMasterUrl
[junit4] 2> 1795934 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3d1dad3f{HTTP/1.1,[http/1.1]}{127.0.0.1:०}
[junit4] 2> 1795934 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1530321060
[junit4] 2> 1795935 INFO (coreCloseExecutor-6431-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@34027e3
[junit4] 2> 1795936 INFO (coreCloseExecutor-6431-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1795936 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1795937 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7306f5f7{/solr,null,UNAVAILABLE}
[junit4] 2> 1795940 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2a1ee5a4{HTTP/1.1,[http/1.1]}{127.0.0.1:०}
[junit4] 2> 1795940 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1075555231
[junit4] 2> 1795941 INFO (coreCloseExecutor-6433-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4cc106ad
[junit4] 2> 1795942 INFO (coreCloseExecutor-6433-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 1795942 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 1795943 INFO (TEST-TestReplicationHandler.doTestIndexFetchWithMasterUrl-seed#[A76B92EAD53F91C9]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@2c2b0e98{/solr,null,UNAVAILABLE}
[junit4] 2> 1795946 INFO (SUITE-TestReplicationHandler-seed#[A76B92EAD53F91C9]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-6.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_A76B92EAD53F91C9-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {name=PostingsFormat(name=Memory doPackFST= false), id=PostingsFormat(name=Memory doPackFST= false), newname=PostingsFormat(name=Memory doPackFST= false)}, docValues:{}, maxPointsInLeafNode=584, maxMBSortInHeap=6.833850380381212, sim=RandomSimilarity(queryNorm=true,coord=yes): {}, locale=hi-IN, timezone=PNT
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_102 (64-bit)/cpus=3,threads=1,free=308652856,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestNumericTerms64, HLLUtilTest, TestDeleteCollectionOnDownNodes, DebugComponentTest, TestStressUserVersions, BadIndexSchemaTest, CdcrReplicationHandlerTest, SaslZkACLProviderTest, OverseerModifyCollectionTest, ClassificationUpdateProcessorFactoryTest, TestDFRSimilarityFactory, TestJsonFacetRefinement, RequestHandlersTest, TestDistributedStatsComponentCardinality, TestZkChroot, StatsReloadRaceTest, CdcrVersionReplicationTest, SortSpecParsingTest, RulesTest, TestMiniSolrCloudClusterSSL, TestSerializedLuceneMatchVersion, DistributedTermsComponentTest, EchoParamsTest, TestUseDocValuesAsStored2, TestRecoveryHdfs, TestQuerySenderNoQuery, TestSearcherReuse, DocExpirationUpdateProcessorFactoryTest, HdfsUnloadDistributedZkTest, SearchHandlerTest, TestStressLiveNodes, DeleteInactiveReplicaTest, UpdateParamsTest, TolerantUpdateProcessorTest, ScriptEngineTest, TestSchemaSimilarityResource, SuggesterTSTTest, TestJoin, ParsingFieldUpdateProcessorsTest, ResponseHeaderTest, SuggestComponentContextFilterQueryTest, ConvertedLegacyTest, MinimalSchemaTest, DateMathParserTest, TestFileDictionaryLookup, TestDelegationWithHadoopAuth, LoggingHandlerTest, TestSolrCloudWithHadoopAuthPlugin, DefaultValueUpdateProcessorTest, JavabinLoaderTest, SolrIndexSplitterTest, RegexBoostProcessorTest, TestDocSet, TestSolrCoreProperties, ShufflingReplicaListTransformerTest, RAMDirectoryFactoryTest, TestBulkSchemaAPI, StatsComponentTest, TestSearchPerf, CopyFieldTest, TestDFISimilarityFactory, TestRealTimeGet, QueryParsingTest, TestSSLRandomization, TestCoreDiscovery, OpenCloseCoreStressTest, TestHdfsCloudBackupRestore, TestRTimerTree, TestPerFieldSimilarityClassic, CollectionsAPIDistributedZkTest, DistributedFacetPivotLargeTest, TestMinMaxOnMultiValuedField, FacetPivotSmallTest, TestAuthenticationFramework, TestSolrDeletionPolicy2, CSVRequestHandlerTest, TestDocTermOrds, CurrencyFieldOpenExchangeTest, SuggesterTest, BlockDirectoryTest, TemplateUpdateProcessorTest, DeleteShardTest, InfoHandlerTest, TestFuzzyAnalyzedSuggestions, TestSolrFieldCacheMBean, AliasIntegrationTest, RequestLoggingTest, CleanupOldIndexTest, CdcrBootstrapTest, TestConfigSetProperties, TestHashQParserPlugin, TestXmlQParser, FullHLLTest, ExternalFileFieldSortTest, SolrCoreCheckLockOnStartupTest, TestCustomSort, DistributedIntervalFacetingTest, TestCopyFieldCollectionResource, DistributedFacetPivotSmallAdvancedTest, ExitableDirectoryReaderTest, CreateCollectionCleanupTest, TestRawResponseWriter, BasicZkTest, DirectUpdateHandlerOptimizeTest, TestCloudPseudoReturnFields, TestSolrCloudWithSecureImpersonation, DistributedFacetPivotWhiteBoxTest, TestAuthorizationFramework, TestManagedSchemaThreadSafety, FileBasedSpellCheckerTest, ClusterStateTest, MergeStrategyTest, TestSolrQueryResponse, TestHdfsUpdateLog, BinaryUpdateRequestHandlerTest, UpdateRequestProcessorFactoryTest, TestPHPSerializedResponseWriter, SuggesterWFSTTest, TestSuggestSpellingConverter, AnalyticsQueryTest, TestDownShardTolerantSearch, TestDynamicLoading, SpellPossibilityIteratorTest, CoreSorterTest, TestDynamicFieldCollectionResource, ConnectionReuseTest, TestValueSourceCache, DistanceFunctionTest, TestMacros, TestLMJelinekMercerSimilarityFactory, HdfsDirectoryTest, TestQuerySenderListener, SolrCmdDistributorTest, TestCrossCoreJoin, TestConfig, TestAnalyzeInfixSuggestions, SolrJmxReporterTest, ForceLeaderTest, TestRandomFaceting, PeerSyncWithIndexFingerprintCachingTest, NoCacheHeaderTest, TestRuleBasedAuthorizationPlugin, TestManagedResourceStorage, UUIDFieldTest, TestManagedStopFilterFactory, DocValuesMissingTest, TestReplicationHandlerBackup, AsyncCallRequestStatusResponseTest, TestManagedSchema, TestRecovery, TestGeoJSONResponseWriter, TestSchemalessBufferedUpdates, CacheHeaderTest, TestIndexSearcher, CircularListTest, TestOmitPositions, TestTrie, HdfsRecoverLeaseTest, HighlighterConfigTest, TestRangeQuery, ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test, SyncSliceTest, OverseerTest, LeaderElectionIntegrationTest, ShardRoutingTest, FullSolrCloudDistribCmdsTest, TestReplicationHandler]
[junit4] Completed [332/678 (1!)] on J1 in 139.81s, 15 tests, 1 failure, 1 skipped <<< FAILURES!
[...truncated 63642 lines...]