Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3775/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestDetails
Error Message:
Stack Trace:
java.lang.NullPointerException
at
__randomizedtesting.SeedInfo.seed([974B6367472249FC:ED164012D17A6074]:0)
at
org.apache.solr.handler.TestReplicationHandler.doTestDetails(TestReplicationHandler.java:312)
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)
FAILED: org.apache.solr.cloud.PeerSyncReplicationTest.test
Error Message:
timeout waiting to see all nodes active
Stack Trace:
java.lang.AssertionError: timeout waiting to see all nodes active
at
__randomizedtesting.SeedInfo.seed([974B6367472249FC:1F1F5CBDE9DE2404]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.PeerSyncReplicationTest.waitTillNodesActive(PeerSyncReplicationTest.java:326)
at
org.apache.solr.cloud.PeerSyncReplicationTest.bringUpDeadNodeAndEnsureNoReplication(PeerSyncReplicationTest.java:277)
at
org.apache.solr.cloud.PeerSyncReplicationTest.forceNodeFailureAndDoPeerSync(PeerSyncReplicationTest.java:259)
at
org.apache.solr.cloud.PeerSyncReplicationTest.test(PeerSyncReplicationTest.java:138)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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 10679 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> Creating dataDir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/init-core-data-001
[junit4] 2> 13245 INFO
(SUITE-TestReplicationHandler-seed#[974B6367472249FC]-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] IGNOR/A 0.01s J0 |
TestReplicationHandler.doTestIndexFetchOnMasterRestart
[junit4] > Assumption #1: 'awaitsfix' test group is disabled
(@AwaitsFix(bugUrl=https://issues.apache.org/jira/browse/SOLR-9036))
[junit4] 2> 13261 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 13262 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1
[junit4] 2> 14222 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 14387 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@57cf897d{/solr,null,AVAILABLE}
[junit4] 2> 14462 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@586ebdfd{HTTP/1.1,[http/1.1]}{127.0.0.1:58729}
[junit4] 2> 14463 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server Started @23275ms
[junit4] 2> 14463 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1/data,
hostContext=/solr, hostPort=58729}
[junit4] 2> 14539 ERROR
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 14539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 7.0.0
[junit4] 2> 14539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone
mode on port null
[junit4] 2> 14539 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 14561 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:55:57.440Z
[junit4] 2> 14564 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
find system property or JNDI)
[junit4] 2> 14570 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/solr.xml
[junit4] 2> 14693 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/.
[junit4] 2> 14696 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 14732 WARN (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 14735 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 14768 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 14855 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 14860 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1
[junit4] 2> 14861 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1/data/]
[junit4] 2> 14867 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 14930 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 14931 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 14931 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 14939 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@24f2d6cb[collection1] main]
[junit4] 2> 14941 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1/conf
[junit4] 2> 14943 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Replication enabled for following config files:
schema.xml,xslt/dummy.xsl
[junit4] 2> 14943 INFO (coreLoadExecutor-18-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 14944 INFO
(searcherExecutor-19-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@24f2d6cb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 15524 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1
[junit4] 2> 15551 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 15564 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2f8ab4f5{/solr,null,AVAILABLE}
[junit4] 2> 15566 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@4978135d{HTTP/1.1,[http/1.1]}{127.0.0.1:58730}
[junit4] 2> 15566 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server Started @24379ms
[junit4] 2> 15567 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=58730}
[junit4] 2> 15567 ERROR
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 15570 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 7.0.0
[junit4] 2> 15570 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone
mode on port null
[junit4] 2> 15570 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 15570 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:55:58.468Z
[junit4] 2> 15572 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/solr.xml
[junit4] 2> 15626 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/.
[junit4] 2> 15626 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 15651 WARN (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 15652 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 15688 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 15698 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 15715 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/./collection1
[junit4] 2> 15716 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/./collection1/data/]
[junit4] 2> 15720 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 15754 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 15754 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 15754 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 15756 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@795ac174[collection1] main]
[junit4] 2> 15757 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1/conf
[junit4] 2> 15799 INFO (coreLoadExecutor-28-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 15800 INFO
(searcherExecutor-29-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@795ac174[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 16201 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@4978135d{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 16201 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=646367366
[junit4] 2> 16204 INFO (coreCloseExecutor-34-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@35d9e6cc
[junit4] 2> 16210 INFO (coreCloseExecutor-34-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 16212 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 16222 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2f8ab4f5{/solr,null,UNAVAILABLE}
[junit4] 2> 16233 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@586ebdfd{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 16233 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=403375723
[junit4] 2> 16238 INFO (coreCloseExecutor-36-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6bb76af5
[junit4] 2> 16243 INFO (coreCloseExecutor-36-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 16244 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 16245 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@57cf897d{/solr,null,UNAVAILABLE}
[junit4] 2> 16251 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 16255 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1465260c{/solr,null,AVAILABLE}
[junit4] 2> 16256 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@36e65bb9{HTTP/1.1,[http/1.1]}{127.0.0.1:58731}
[junit4] 2> 16256 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server Started @25068ms
[junit4] 2> 16256 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1/data,
hostContext=/solr, hostPort=58731}
[junit4] 2> 16258 ERROR
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 16258 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 7.0.0
[junit4] 2> 16259 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone
mode on port null
[junit4] 2> 16259 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 16259 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:55:59.157Z
[junit4] 2> 16259 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/solr.xml
[junit4] 2> 16323 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/.
[junit4] 2> 16324 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 16367 WARN (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 16369 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 16401 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 16410 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 16418 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1
[junit4] 2> 16419 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1/data/]
[junit4] 2> 16423 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 16456 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 16457 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 16458 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 16460 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@648c3b0[collection1] main]
[junit4] 2> 16461 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1/conf
[junit4] 2> 16461 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Replication enabled for following config files:
schema.xml
[junit4] 2> 16462 INFO (coreLoadExecutor-43-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 16462 INFO
(searcherExecutor-44-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@648c3b0[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19118 INFO (qtp412720071-62) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 19123 INFO (qtp412720071-62) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{deleteByQuery=*:*} 0 338
[junit4] 2> 19279 INFO (qtp412720071-63) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 19279 INFO (qtp412720071-63) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@7e508267
[junit4] 2> 19284 INFO (qtp412720071-63) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@31aa69e6[collection1] main]
[junit4] 2> 19285 INFO (qtp412720071-63) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 19287 INFO
(searcherExecutor-44-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@31aa69e6[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 19287 INFO (qtp412720071-63) [ 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 9
[junit4] 2> 19549 INFO (qtp412720071-64) [ 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=233
[junit4] 2> 19614 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 19618 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 19623 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@917c9f4{/solr,null,AVAILABLE}
[junit4] 2> 19624 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@1e2a2b25{HTTP/1.1,[http/1.1]}{127.0.0.1:58733}
[junit4] 2> 19624 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.Server Started @28437ms
[junit4] 2> 19625 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1/data,
hostContext=/solr, hostPort=58733}
[junit4] 2> 19626 ERROR
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 19627 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 7.0.0
[junit4] 2> 19627 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone
mode on port null
[junit4] 2> 19627 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 19627 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:56:02.525Z
[junit4] 2> 19628 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/solr.xml
[junit4] 2> 19658 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/.
[junit4] 2> 19658 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 19726 WARN (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 19731 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 19752 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 19774 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 19778 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/./collection1
[junit4] 2> 19778 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/./collection1/data/]
[junit4] 2> 19785 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 19816 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 19816 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 19817 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 19819 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@21c1062[collection1] main]
[junit4] 2> 19820 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-002/collection1/conf
[junit4] 2> 19822 INFO (coreLoadExecutor-53-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 19824 INFO
(searcherExecutor-54-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@21c1062[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 20193 INFO (qtp412720071-66) [ 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> 20195 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 20195 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1484279762178
[junit4] 2> 20195 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 20195 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 20205 INFO (qtp412720071-67) [ 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=7
[junit4] 2> 20206 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 1
[junit4] 2> 20218 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=222339197,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 20223 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 20225 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@6bd55f9
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ccefb01))
[junit4] 2> 20227 INFO (qtp1150381692-80) [ 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=1
[junit4] 2> 20228 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 20242 INFO (qtp412720071-60) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
status=0 QTime=0
[junit4] 2> 20245 INFO (qtp412720071-63) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits}
status=0 QTime=0
[junit4] 2> 20252 INFO (qtp412720071-62) [ 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=7
[junit4] 2> 20287 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=100) : 0 secs (null bytes/sec) to
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@6bd55f9
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@4ccefb01))
[junit4] 2> 20319 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.8154296875,
noCFSRatio=0.8807969959450723]
[junit4] 2> 20337 WARN (qtp412720071-64) [ ] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 20339 INFO (qtp412720071-64) [ ] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 20362 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 20373 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@751679a1[collection1] main]
[junit4] 2> 20374 INFO
(searcherExecutor-54-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@751679a1[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 20387 INFO (qtp412720071-64) [ ] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 20393 INFO (qtp412720071-64) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 20402 INFO (qtp412720071-64) [ ] o.a.s.c.CoreContainer
Reloading SolrCore 'collection1' using configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1
[junit4] 2> 20404 INFO (qtp412720071-64) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/./collection1/data/]
[junit4] 2> 20441 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 20442 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 20444 INFO (qtp412720071-64) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3c8cba37[collection1] main]
[junit4] 2> 20444 INFO (qtp412720071-64) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-001/collection1/conf
[junit4] 2> 20445 INFO (qtp412720071-64) [ x:collection1]
o.a.s.h.ReplicationHandler Replication enabled for following config files:
schema.xml
[junit4] 2> 20445 INFO (qtp412720071-64) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 20446 INFO
(searcherExecutor-60-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3c8cba37[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 20459 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=40, maxMergeAtOnceExplicit=24, maxMergedSegmentMB=5.927734375,
floorSegmentMB=2.0380859375, forceMergeDeletesPctAllowed=8.388734319737734,
segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 20475 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 20476 INFO (qtp412720071-64) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@26efca43[collection1] main]
[junit4] 2> 20476 INFO (qtp412720071-64) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6cc76944
[junit4] 2> 20477 INFO
(searcherExecutor-60-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@26efca43[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 20479 INFO (qtp412720071-64) [ x:collection1]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
[junit4] 2> 20479 INFO (qtp412720071-64) [ x:collection1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={core=collection1&qt=/admin/cores&action=reload&wt=javabin&version=2}
status=0 QTime=228
[junit4] 2> 20483 INFO (qtp412720071-66) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getIndexVersion&qt=/replication&wt=javabin&version=2&command=indexversion}
status=0 QTime=0
[junit4] 2> 20486 INFO (qtp412720071-67) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={_trace=getCommits&qt=/replication&wt=javabin&version=2&command=commits}
status=0 QTime=0
[junit4] 2> 21080 INFO (qtp412720071-63) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[10]} 0 586
[junit4] 2> 21084 INFO (qtp412720071-62) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[20]} 0 1
[junit4] 2> 21087 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 21087 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@5f8eed3e
[junit4] 2> 21184 INFO (qtp412720071-66) [ 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> 21186 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 21186 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1484279762178
[junit4] 2> 21186 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 21186 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave in sync with master.
[junit4] 2> 21948 INFO (qtp412720071-64) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3b22d832[collection1] main]
[junit4] 2> 21949 INFO (qtp412720071-64) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 21949 INFO
(searcherExecutor-60-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3b22d832[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c2)))}
[junit4] 2> 21949 INFO (qtp412720071-64) [ 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 862
[junit4] 2> 22187 INFO (qtp412720071-66) [ 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> 22189 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 22189 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1484279763986
[junit4] 2> 22189 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 22189 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 22220 INFO (qtp412720071-64) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=266
[junit4] 2> 22246 INFO (qtp412720071-60) [ 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=55
[junit4] 2> 22247 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
[junit4] 2> 22247 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
[junit4] 2> 22250 INFO (qtp1150381692-81) [ 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> 22251 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 22253 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=25, maxMergeAtOnceExplicit=34, maxMergedSegmentMB=96.42578125,
floorSegmentMB=0.7900390625, forceMergeDeletesPctAllowed=9.610712408292965,
segmentsPerTier=39.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.10890881213391596
[junit4] 2> 22255 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 22256 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@64608983
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@55db1fb7))
[junit4] 2> 22264 INFO (qtp412720071-67) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 22282 INFO (qtp412720071-63) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 22290 INFO (qtp412720071-62) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=3&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 22312 INFO (qtp412720071-65) [ 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> 22314 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Total time taken for download
(fullCopy=false,bytesDownloaded=1955) : 0 secs (null bytes/sec) to
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@64608983
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@55db1fb7))
[junit4] 2> 22320 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=21, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=41.6279296875,
floorSegmentMB=2.1962890625, forceMergeDeletesPctAllowed=29.29202384751424,
segmentsPerTier=16.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.7359668286916957
[junit4] 2> 22326 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 22331 INFO (indexFetcher-58-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@9522d84[collection1] main]
[junit4] 2> 22332 INFO
(searcherExecutor-54-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@9522d84[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c2)))}
[junit4] 2> 22357 INFO (qtp1150381692-82) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/select
params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=2
[junit4] 2> 22358 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.h.TestReplicationHandler Waited for 100ms and found 2 docs
[junit4] 2> 22358 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 22364 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@36e65bb9{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 22365 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=947913943
[junit4] 2> 22366 INFO (coreCloseExecutor-65-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@6bc9edfe
[junit4] 2> 22371 INFO (coreCloseExecutor-65-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 22372 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 22373 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@1465260c{/solr,null,UNAVAILABLE}
[junit4] 2> 22376 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Stopped
ServerConnector@1e2a2b25{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 22377 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1569595310
[junit4] 2> 22378 INFO (coreCloseExecutor-67-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7953775f
[junit4] 2> 22385 INFO (coreCloseExecutor-67-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 22387 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 22388 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@917c9f4{/solr,null,UNAVAILABLE}
[junit4] 2> 22395 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting doTestDetails
[junit4] 2> 22396 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/collection1
[junit4] 2> 22409 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 22412 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@478fd148{/solr,null,AVAILABLE}
[junit4] 2> 22414 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@38e68ceb{HTTP/1.1,[http/1.1]}{127.0.0.1:58738}
[junit4] 2> 22414 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.Server Started @31226ms
[junit4] 2> 22414 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/collection1/data,
hostContext=/solr, hostPort=58738}
[junit4] 2> 22415 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 22415 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 22415 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 22415 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 22415 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:56:05.313Z
[junit4] 2> 22416 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/solr.xml
[junit4] 2> 22456 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/.
[junit4] 2> 22456 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 22507 WARN (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 22509 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 22543 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 22556 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 22560 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/./collection1
[junit4] 2> 22560 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/./collection1/data/]
[junit4] 2> 22563 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 22599 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 22599 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 22600 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 22602 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@696ff4ff[collection1] main]
[junit4] 2> 22603 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-003/collection1/conf
[junit4] 2> 22603 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Replication enabled for following config files:
schema.xml,xslt/dummy.xsl
[junit4] 2> 22604 INFO (coreLoadExecutor-74-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 22604 INFO
(searcherExecutor-75-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@696ff4ff[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23010 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/collection1
[junit4] 2> 23027 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 23034 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@ae3b177{/solr,null,AVAILABLE}
[junit4] 2> 23035 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@1c00d043{HTTP/1.1,[http/1.1]}{127.0.0.1:58739}
[junit4] 2> 23035 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.Server Started @31847ms
[junit4] 2> 23035 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/collection1/data,
hostContext=/solr, hostPort=58739}
[junit4] 2> 23040 ERROR
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 23041 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 23041 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on
port null
[junit4] 2> 23042 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 23042 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:56:05.940Z
[junit4] 2> 23043 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/solr.xml
[junit4] 2> 23079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/.
[junit4] 2> 23079 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 23117 WARN (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use
<mergePolicyFactory> instead.
[junit4] 2> 23119 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 23147 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 23160 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 23168 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/./collection1
[junit4] 2> 23169 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/collection1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/./collection1/data/]
[junit4] 2> 23172 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=9, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 23294 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 23294 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 23295 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=29, maxMergeAtOnceExplicit=25, maxMergedSegmentMB=62.6591796875,
floorSegmentMB=2.1279296875, forceMergeDeletesPctAllowed=8.85709102675342,
segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 23297 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@41b3d85c[collection1] main]
[junit4] 2> 23297 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-004/collection1/conf
[junit4] 2> 23300 INFO (coreLoadExecutor-84-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 23300 INFO
(searcherExecutor-85-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@41b3d85c[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 23648 INFO (qtp409534918-108) [ 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=16
[junit4] 2> 23670 INFO (qtp409534918-109) [ 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=8
[junit4] 2> 23692 INFO (qtp409534918-110) [ 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> 23695 INFO (qtp1403622655-125) [ 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=11
[junit4] 2> 23708 INFO (qtp409534918-111) [ x:collection1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update
params={wt=javabin&version=2}{add=[0]} 0 4
[junit4] 2> 23712 INFO (qtp409534918-112) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 23712 INFO (qtp409534918-112) [ x:collection1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@6b15a310
[junit4] 2> 23737 INFO (qtp409534918-112) [ x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@498db6eb[collection1] main]
[junit4] 2> 23738 INFO (qtp409534918-112) [ x:collection1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 23738 INFO
(searcherExecutor-75-thread-1-processing-x:collection1) [ x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@498db6eb[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c1)))}
[junit4] 2> 23739 INFO (qtp409534918-112) [ 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 27
[junit4] 2> 23870 INFO (qtp409534918-113) [ 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> 23875 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 23878 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Master's version: 1484279766610
[junit4] 2> 23878 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 23878 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 23880 INFO (qtp1403622655-127) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={wait=true&masterUrl=http://127.0.0.1:58738/solr/collection1/replication&command=fetchindex}
status=0 QTime=8
[junit4] 2> 23905 INFO (qtp409534918-106) [ 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=25
[junit4] 2> 23907 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Number of files in latest index in master: 4
[junit4] 2> 23917 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=222339197,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 23921 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 23929 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.IndexFetcher Starting download (fullCopy=false) to
MetricsDirectory(MockDirectoryWrapper(RAMDirectory@5e1a988f
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3b98f372))
[junit4] 2> 23937 INFO (qtp409534918-108) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.cfe&checksum=true&compression=true&wt=filestream&command=filecontent}
status=0 QTime=1
[junit4] 2> 24000 INFO (qtp409534918-111) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.si&checksum=true&compression=true&wt=filestream&command=filecontent}
status=0 QTime=0
[junit4] 2> 24026 INFO (qtp409534918-110) [ 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=33
[junit4] 2> 24034 INFO (qtp1403622655-128) [ 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=58
[junit4] 2> 24037 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending doTestDetails
[junit4] 2> 24038 INFO (qtp409534918-112) [ x:collection1]
o.a.s.c.S.Request [collection1] webapp=/solr path=/replication
params={generation=2&qt=/replication&file=_0.cfs&checksum=true&compression=true&wt=filestream&command=filecontent}
status=0 QTime=2
[junit4] 2> 24045 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@38e68ceb{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 24045 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=805046340
[junit4] 2> 24047 INFO (coreCloseExecutor-91-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@2c772156
[junit4] 2> 24067 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.h.i.e.RetryExec I/O exception (org.apache.http.NoHttpResponseException)
caught when processing request to {}->http://127.0.0.1:58738: The target server
failed to respond
[junit4] 2> 24067 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.h.i.e.RetryExec Retrying request to {}->http://127.0.0.1:58738
[junit4] 2> 24068 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.h.i.e.RetryExec I/O exception (org.apache.http.NoHttpResponseException)
caught when processing request to {}->http://127.0.0.1:58738: The target server
failed to respond
[junit4] 2> 24068 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.h.i.e.RetryExec Retrying request to {}->http://127.0.0.1:58738
[junit4] 2> 24070 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=24, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=0.8154296875,
noCFSRatio=0.8807969959450723]
[junit4] 2> 24071 INFO (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 24083 INFO (coreCloseExecutor-91-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 24083 ERROR (indexFetcher-89-thread-1) [ x:collection1]
o.a.s.h.ReplicationHandler Index fetch failed
:org.apache.solr.common.SolrException: Unable to download segments_2
completely. Downloaded 0!=165
[junit4] 2> at
org.apache.solr.handler.IndexFetcher$FileFetcher.cleanup(IndexFetcher.java:1574)
[junit4] 2> at
org.apache.solr.handler.IndexFetcher$FileFetcher.fetchFile(IndexFetcher.java:1457)
[junit4] 2> at
org.apache.solr.handler.IndexFetcher.downloadIndexFiles(IndexFetcher.java:873)
[junit4] 2> at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:448)
[junit4] 2> at
org.apache.solr.handler.IndexFetcher.fetchLatestIndex(IndexFetcher.java:265)
[junit4] 2> at
org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:397)
[junit4] 2> at
org.apache.solr.handler.ReplicationHandler.lambda$setupPolling$2(ReplicationHandler.java:1143)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.runAndReset(FutureTask.java:308)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:180)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:294)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> 24095 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 24103 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@478fd148{/solr,null,UNAVAILABLE}
[junit4] 2> 24115 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.AbstractConnector Stopped
ServerConnector@1c00d043{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 24116 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=312060960
[junit4] 2> 24129 INFO (coreCloseExecutor-93-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@92ed548
[junit4] 2> 24134 INFO (coreCloseExecutor-93-thread-1) [
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for:
solr.core.collection1
[junit4] 2> 24138 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 24138 INFO
(TEST-TestReplicationHandler.doTestDetails-seed#[974B6367472249FC]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@ae3b177{/solr,null,UNAVAILABLE}
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=TestReplicationHandler -Dtests.method=doTestDetails
-Dtests.seed=974B6367472249FC -Dtests.slow=true -Dtests.locale=es-PY
-Dtests.timezone=Etc/GMT-0 -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] ERROR 1.76s J0 | TestReplicationHandler.doTestDetails <<<
[junit4] > Throwable #1: java.lang.NullPointerException
[junit4] > at
__randomizedtesting.SeedInfo.seed([974B6367472249FC:ED164012D17A6074]:0)
[junit4] > at
org.apache.solr.handler.TestReplicationHandler.doTestDetails(TestReplicationHandler.java:312)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 24149 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testRateLimitedReplication
[junit4] 2> 24151 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/collection1
[junit4] 2> 24165 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 24168 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7e9d46ad{/solr,null,AVAILABLE}
[junit4] 2> 24169 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.e.j.s.AbstractConnector Started
ServerConnector@100c71b6{HTTP/1.1,[http/1.1]}{127.0.0.1:58747}
[junit4] 2> 24169 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.e.j.s.Server Started @32981ms
[junit4] 2> 24169 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/collection1/data,
hostContext=/solr, hostPort=58747}
[junit4] 2> 24170 ERROR
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 24170 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr?
version 7.0.0
[junit4] 2> 24170 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone
mode on port null
[junit4] 2> 24170 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 24170 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-01-13T03:56:07.068Z
[junit4] 2> 24171 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/solr.xml
[junit4] 2> 24211 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/.
[junit4] 2> 24211 INFO
(TEST-TestReplicationHandler.testRateLimitedReplication-seed#[974B6367472249FC])
[ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 24271 WARN (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is
deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 24273 INFO (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 24294 INFO (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 24304 INFO (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 24315 INFO (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using
configuration from instancedir
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/./collection1
[junit4] 2> 24316 INFO (coreLoadExecutor-100-thread-1) [
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_974B6367472249FC-001/solr-instance-005/collection1],
dataDir=[/Users/
[...truncated too long message...]
unit4] 2> 333038 INFO (qtp1791812784-891) [n:127.0.0.1:59088_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:59093_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node2&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=400 QTime=162032
[junit4] 2> 333038 INFO (qtp1791812784-896) [n:127.0.0.1:59088_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:59093_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node2&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=400 QTime=172045
[junit4] 2> 333039 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.ChaosMonkey monkey: stop shard! 59093
[junit4] 2> 333039 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1828272055
[junit4] 2> 333039 WARN
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.RecoveryStrategy Stopping recovery for core=[collection1]
coreNodeName=[core_node2]
[junit4] 2> 333043 WARN
(updateExecutor-172-thread-2-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.u.DefaultSolrCoreState
Skipping recovery because Solr is shutdown
[junit4] 2> 333163 INFO
(zkCallback-175-thread-4-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [1])
[junit4] 2> 337268 INFO
(recoveryExecutor-173-thread-1-processing-n:127.0.0.1:59093_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:59093_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy RecoveryStrategy has been
closed
[junit4] 2> 337268 INFO
(recoveryExecutor-173-thread-1-processing-n:127.0.0.1:59093_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:59093_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy Finished recovery process,
successful=[false]
[junit4] 2> 337269 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.Overseer Overseer (id=97273765407096851-127.0.0.1:59093_-n_0000000004)
closing
[junit4] 2> 337269 INFO
(OverseerStateUpdate-97273765407096851-127.0.0.1:59093_-n_0000000004)
[n:127.0.0.1:59093_ ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:59093_
[junit4] 2> 337271 WARN
(zkCallback-175-thread-4-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to
ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 338781 INFO
(zkCallback-175-thread-2-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.SolrCore
[collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@69c7908f
[junit4] 2> 338782 WARN
(zkCallback-175-thread-2-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy
Stopping recovery for core=[collection1] coreNodeName=[core_node2]
[junit4] 2> 343667 INFO
(zkCallback-175-thread-2-processing-n:127.0.0.1:59093_) [n:127.0.0.1:59093_
c:collection1 s:shard1 r:core_node2 x:collection1] o.a.s.m.SolrMetricManager
Closing metric reporters for: solr.core.collection1
[junit4] 2> 343667 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
[junit4] 2> 343669 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@7ad67234{SSL,[ssl,
http/1.1]}{127.0.0.1:59093}
[junit4] 2> 343669 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@423b9103{/,null,UNAVAILABLE}
[junit4] 2> 343671 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.ChaosMonkey monkey: stop shard! 59100
[junit4] 2> 343673 INFO
(TEST-PeerSyncReplicationTest.test-seed#[974B6367472249FC]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:59071 59071
[junit4] 2> 343689 INFO (Thread-223) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:59071 59071
[junit4] 2> 347744 WARN (Thread-223) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/aliases.json
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 6 /solr/clusterstate.json
[junit4] 2> 6 /solr/clusterprops.json
[junit4] 2> 4 /solr/collections/collection1/state.json
[junit4] 2> 2
/solr/collections/collection1/leader_elect/shard1/election/97273765407096842-core_node1-n_0000000000
[junit4] 2> 2
/solr/overseer_elect/election/97273765407096842-127.0.0.1:59088_-n_0000000001
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 211 /solr/overseer/collection-queue-work
[junit4] 2> 46 /solr/overseer/queue
[junit4] 2> 20 /solr/overseer/queue-work
[junit4] 2> 6 /solr/collections
[junit4] 2> 5 /solr/live_nodes
[junit4] 2>
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=PeerSyncReplicationTest -Dtests.method=test
-Dtests.seed=974B6367472249FC -Dtests.slow=true -Dtests.locale=de-CH
-Dtests.timezone=Asia/Taipei -Dtests.asserts=true -Dtests.file.encoding=US-ASCII
[junit4] FAILURE 223s J1 | PeerSyncReplicationTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: timeout waiting to see
all nodes active
[junit4] > at
__randomizedtesting.SeedInfo.seed([974B6367472249FC:1F1F5CBDE9DE2404]:0)
[junit4] > at
org.apache.solr.cloud.PeerSyncReplicationTest.waitTillNodesActive(PeerSyncReplicationTest.java:326)
[junit4] > at
org.apache.solr.cloud.PeerSyncReplicationTest.bringUpDeadNodeAndEnsureNoReplication(PeerSyncReplicationTest.java:277)
[junit4] > at
org.apache.solr.cloud.PeerSyncReplicationTest.forceNodeFailureAndDoPeerSync(PeerSyncReplicationTest.java:259)
[junit4] > at
org.apache.solr.cloud.PeerSyncReplicationTest.test(PeerSyncReplicationTest.java:138)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 347795 INFO
(SUITE-PeerSyncReplicationTest-seed#[974B6367472249FC]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.PeerSyncReplicationTest_974B6367472249FC-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70):
{other_tl1=PostingsFormat(name=Asserting),
range_facet_l_dv=Lucene50(blocksize=128), rnd_s=PostingsFormat(name=Asserting),
multiDefault=BlockTreeOrds(blocksize=128),
intDefault=PostingsFormat(name=Asserting), a_i1=BlockTreeOrds(blocksize=128),
range_facet_l=BlockTreeOrds(blocksize=128),
_version_=PostingsFormat(name=Asserting), a_t=BlockTreeOrds(blocksize=128),
id=Lucene50(blocksize=128), range_facet_i_dv=BlockTreeOrds(blocksize=128),
text=FST50, timestamp=BlockTreeOrds(blocksize=128)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene70),
range_facet_i_dv=DocValuesFormat(name=Direct),
timestamp=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=192,
maxMBSortInHeap=7.443869527158073, sim=RandomSimilarity(queryNorm=true): {},
locale=de-CH, timezone=Asia/Taipei
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_102
(64-bit)/cpus=3,threads=1,free=104685336,total=266338304
[junit4] 2> NOTE: All tests run in this JVM: [TestExactStatsCache,
BlockCacheTest, TestInfoStreamLogging, ClusterStateTest,
TestShardHandlerFactory, HdfsThreadLeakTest, TestSSLRandomization, BasicZkTest,
LeaderInitiatedRecoveryOnShardRestartTest, PreAnalyzedUpdateProcessorTest,
RulesTest, TriLevelCompositeIdRoutingTest, PeerSyncReplicationTest]
[junit4] Completed [50/678 (2!)] on J1 in 223.11s, 1 test, 1 failure <<<
FAILURES!
[...truncated 2044 lines...]
[junit4] JVM J0: stdout was not empty, see:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/temp/junit4-J0-20170113_035533_965.sysout
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] java.lang.OutOfMemoryError: Java heap space
[junit4] Dumping heap to
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/heapdumps/java_pid74946.hprof
...
[junit4] Heap dump file created [574684095 bytes in 31.325 secs]
[junit4] <<< JVM J0: EOF ----
[...truncated 11633 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:775: The following
error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:727: Some of the
tests produced a heap dump, but did not fail. Maybe a suppressed
OutOfMemoryError? Dumps created:
* java_pid74946.hprof
Total time: 102 minutes 1 second
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
