You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/12/23 18:48:21 UTC
[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk1.8.0_144) - Build # 1035
- Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/1035/
Java: 64bit/jdk1.8.0_144 -XX:-UseCompressedOops -XX:+UseParallelGC
1 tests failed.
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication
Error Message:
Index: 0, Size: 0
Stack Trace:
java.lang.IndexOutOfBoundsException: Index: 0, Size: 0
at __randomizedtesting.SeedInfo.seed([A91EB842A762D22B:BD56E31784656F35]:0)
at java.util.ArrayList.rangeCheck(ArrayList.java:653)
at java.util.ArrayList.get(ArrayList.java:429)
at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:561)
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:1737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
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:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
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:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12151 lines...]
[junit4] Suite: org.apache.solr.handler.TestReplicationHandler
[junit4] 2> 314997 INFO (SUITE-TestReplicationHandler-seed#[A91EB842A762D22B]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/init-core-data-001
[junit4] 2> 314998 WARN (SUITE-TestReplicationHandler-seed#[A91EB842A762D22B]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 314998 INFO (SUITE-TestReplicationHandler-seed#[A91EB842A762D22B]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 314998 INFO (SUITE-TestReplicationHandler-seed#[A91EB842A762D22B]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 315000 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting doTestReplicateAfterCoreReload
[junit4] 2> 315001 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1
[junit4] 2> 315002 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 315014 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@10f7d1{/solr,null,AVAILABLE}
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3f94a3b4{HTTP/1.1,[http/1.1]}{127.0.0.1:34043}
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @317200ms
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=34043}
[junit4] 2> 315016 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 315016 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:25.933Z
[junit4] 2> 315017 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/solr.xml
[junit4] 2> 315020 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 315020 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 315021 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 315055 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315063 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315067 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315069 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/.
[junit4] 2> 315069 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 315075 INFO (coreLoadExecutor-926-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 315093 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 315108 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 315110 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 315110 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1, trusted=true
[junit4] 2> 315110 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315110 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 315110 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1/data/]
[junit4] 2> 315112 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=24.66015625, floorSegmentMB=0.2841796875, forceMergeDeletesPctAllowed=25.47319963427799, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11809655113127962
[junit4] 2> 315162 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 315162 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 315163 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 315163 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@344eab38[collection1] main]
[junit4] 2> 315164 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1/conf
[junit4] 2> 315164 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 315164 INFO (coreLoadExecutor-926-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 315165 INFO (searcherExecutor-927-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@344eab38[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315167 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1
[junit4] 2> 315169 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 315185 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5d7f5207{/solr,null,AVAILABLE}
[junit4] 2> 315186 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@40e5ecca{HTTP/1.1,[http/1.1]}{127.0.0.1:38975}
[junit4] 2> 315186 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @317371ms
[junit4] 2> 315186 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=38975}
[junit4] 2> 315186 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 315186 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 315187 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 315187 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 315187 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:26.104Z
[junit4] 2> 315187 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/solr.xml
[junit4] 2> 315190 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 315190 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 315191 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 315213 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315218 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315218 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315220 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/.
[junit4] 2> 315220 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 315220 INFO (coreLoadExecutor-936-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 315229 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 315235 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 315236 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 315236 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/./collection1, trusted=true
[junit4] 2> 315236 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315236 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 315237 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/./collection1/data/]
[junit4] 2> 315238 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=24.66015625, floorSegmentMB=0.2841796875, forceMergeDeletesPctAllowed=25.47319963427799, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11809655113127962
[junit4] 2> 315277 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 315277 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 315278 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 315278 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@47195564[collection1] main]
[junit4] 2> 315279 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1/conf
[junit4] 2> 315280 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 315280 INFO (coreLoadExecutor-936-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 315282 INFO (searcherExecutor-937-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@47195564[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315282 INFO (qtp2131174500-2503) [ 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> 315283 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 315283 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 315283 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 315283 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 315283 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 315284 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@40e5ecca{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 315286 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1729006458
[junit4] 2> 315286 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 315286 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@51e14fec commitCommandVersion:0
[junit4] 2> 315287 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 315287 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@773f6ac: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@7cc2c345
[junit4] 2> 315288 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7a4358de[collection1] main]
[junit4] 2> 315288 INFO (indexFetcher-941-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 315291 INFO (searcherExecutor-937-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7a4358de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315293 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 315293 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1a0a7752: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 315297 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 315297 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@ea40594: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 315298 INFO (coreCloseExecutor-942-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@6733ba18
[junit4] 2> 315298 INFO (coreCloseExecutor-942-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1731443224
[junit4] 2> 315298 INFO (coreCloseExecutor-942-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5c22eaf: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@56d38d87
[junit4] 2> 315307 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5d7f5207{/solr,null,UNAVAILABLE}
[junit4] 2> 315319 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@3f94a3b4{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 315319 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2132488915
[junit4] 2> 315319 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 315319 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5893086c: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@697af8a0
[junit4] 2> 315320 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 315320 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2423044f: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 315321 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 315321 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@72a81832: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 315322 INFO (coreCloseExecutor-944-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@58d61568
[junit4] 2> 315322 INFO (coreCloseExecutor-944-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1490425192
[junit4] 2> 315322 INFO (coreCloseExecutor-944-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2894ef67: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@79006675
[junit4] 2> 315324 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@10f7d1{/solr,null,UNAVAILABLE}
[junit4] 2> 315325 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5b54fab3{/solr,null,AVAILABLE}
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@2338735c{HTTP/1.1,[http/1.1]}{127.0.0.1:46217}
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @317511ms
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1/data, hostContext=/solr, hostPort=46217}
[junit4] 2> 315327 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 315327 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:26.244Z
[junit4] 2> 315328 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/solr.xml
[junit4] 2> 315330 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 315330 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 315331 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 315348 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315353 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315353 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315354 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/.
[junit4] 2> 315354 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 315356 INFO (coreLoadExecutor-951-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 315365 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 315371 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 315373 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 315373 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1, trusted=true
[junit4] 2> 315373 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315373 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 315374 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1/data/]
[junit4] 2> 315375 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=24.66015625, floorSegmentMB=0.2841796875, forceMergeDeletesPctAllowed=25.47319963427799, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11809655113127962
[junit4] 2> 315407 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 315407 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 315408 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 315408 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@766f6339[collection1] main]
[junit4] 2> 315408 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1/conf
[junit4] 2> 315408 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 315409 INFO (coreLoadExecutor-951-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 315409 INFO (searcherExecutor-952-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@766f6339[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315911 INFO (qtp1086532120-2545) [ x:collection1] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
[junit4] 2> 315912 INFO (qtp1086532120-2545) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
[junit4] 2> 315912 INFO (qtp1086532120-2546) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 315912 INFO (qtp1086532120-2546) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@791a627e commitCommandVersion:0
[junit4] 2> 315913 INFO (qtp1086532120-2546) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@36e08916[collection1] main]
[junit4] 2> 315913 INFO (qtp1086532120-2546) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 315921 INFO (searcherExecutor-952-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@36e08916[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315922 INFO (qtp1086532120-2546) [ 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> 315922 INFO (qtp1086532120-2547) [ 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> 315923 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 315931 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 315932 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7054a795{/solr,null,AVAILABLE}
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@768ca4cc{HTTP/1.1,[http/1.1]}{127.0.0.1:45047}
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @318117ms
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1/data, hostContext=/solr, hostPort=45047}
[junit4] 2> 315933 ERROR (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 315933 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:26.850Z
[junit4] 2> 315934 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/solr.xml
[junit4] 2> 315937 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 315937 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 315938 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 315965 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315974 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315974 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315976 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/.
[junit4] 2> 315976 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 315976 INFO (coreLoadExecutor-961-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 315987 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 315993 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 315995 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 315995 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/./collection1, trusted=true
[junit4] 2> 315995 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 315996 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 315996 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/./collection1/data/]
[junit4] 2> 315997 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=24.66015625, floorSegmentMB=0.2841796875, forceMergeDeletesPctAllowed=25.47319963427799, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11809655113127962
[junit4] 2> 316037 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 316037 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 316038 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 316038 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2912b70f[collection1] main]
[junit4] 2> 316039 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-002/collection1/conf
[junit4] 2> 316040 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
[junit4] 2> 316040 INFO (coreLoadExecutor-961-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 316042 INFO (searcherExecutor-962-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@2912b70f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 316042 INFO (qtp1086532120-2545) [ 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> 316043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 2
[junit4] 2> 316043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1514051426829
[junit4] 2> 316043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 316043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 316043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 316044 INFO (qtp1086532120-2545) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist} status=0 QTime=1
[junit4] 2> 316044 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 1
[junit4] 2> 316046 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=2096348832, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 316047 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 316047 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@430da9ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65b96e5d)
[junit4] 2> 316047 INFO (qtp1086532120-2547) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=2&qt=/replication&file=segments_2&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
[junit4] 2> 316048 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=117) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@430da9ac lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@65b96e5d)
[junit4] 2> 316049 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=38, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
[junit4] 2> 316049 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 316049 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@fc7f261[collection1] main]
[junit4] 2> 316050 INFO (searcherExecutor-962-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@fc7f261[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 316542 INFO (qtp569339940-2563) [ 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> 316543 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 0 docs
[junit4] 2> 316543 INFO (qtp1086532120-2540) [ 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> 316544 INFO (qtp1086532120-2546) [ 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> 316557 INFO (qtp1086532120-2542) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 316571 INFO (qtp1086532120-2542) [ ] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 316573 INFO (qtp1086532120-2542) [ ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 316573 INFO (qtp1086532120-2542) [ ] o.a.s.c.CoreContainer Reloading SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1
[junit4] 2> 316595 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 316595 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/./collection1/data/]
[junit4] 2> 316629 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 316629 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 316631 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@57743ded[collection1] main]
[junit4] 2> 316631 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-001/collection1/conf
[junit4] 2> 316632 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml
[junit4] 2> 316632 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 316633 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=34, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23490501625398982]
[junit4] 2> 316633 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 316633 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@57743ded[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 316633 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@5fac5bfe[collection1] main]
[junit4] 2> 316634 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1707cb07
[junit4] 2> 316634 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=386386695
[junit4] 2> 316634 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@26e9aa08: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@472eaf0f
[junit4] 2> 316634 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5fac5bfe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 316641 INFO (qtp1086532120-2542) [ 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=95
[junit4] 2> 316642 INFO (qtp1086532120-2545) [ 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> 316642 INFO (qtp1086532120-2540) [ 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> 316643 INFO (qtp1086532120-2546) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
[junit4] 2> 316644 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
[junit4] 2> 316644 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 316644 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@3b359bf6 commitCommandVersion:0
[junit4] 2> 316646 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4a527129[collection1] main]
[junit4] 2> 316646 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 316647 INFO (searcherExecutor-968-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4a527129[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):c2)))}
[junit4] 2> 316648 INFO (qtp1086532120-2542) [ x:collection1] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 3
[junit4] 2> 316649 INFO (qtp1086532120-2540) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 316649 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waited for 0ms and found 2 docs
[junit4] 2> 316650 INFO (qtp569339940-2564) [ 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> 316650 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 316750 INFO (qtp569339940-2565) [ 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> 316751 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 316851 INFO (qtp569339940-2558) [ 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> 316851 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 316952 INFO (qtp569339940-2563) [ 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> 316952 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waiting for 2 docs
[junit4] 2> 317040 INFO (qtp1086532120-2541) [ 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> 317041 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 3
[junit4] 2> 317041 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 1514051427561
[junit4] 2> 317041 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 2
[junit4] 2> 317041 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 1514051426829
[junit4] 2> 317041 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting replication process
[junit4] 2> 317042 INFO (qtp1086532120-2545) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/replication params={generation=3&qt=/replication&tlogFiles=false&wt=javabin&version=2&command=filelist} status=0 QTime=0
[junit4] 2> 317042 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
[junit4] 2> 317042 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=32, maxMergeAtOnceExplicit=33, maxMergedSegmentMB=55.0458984375, floorSegmentMB=1.1083984375, forceMergeDeletesPctAllowed=9.07138676172875, segmentsPerTier=14.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0
[junit4] 2> 317043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 317043 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to MockDirectoryWrapper(RAMDirectory@25b3659f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@323dc274)
[junit4] 2> 317043 INFO (qtp1086532120-2542) [ 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> 317044 INFO (qtp1086532120-2546) [ 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> 317045 INFO (qtp1086532120-2541) [ 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> 317046 INFO (qtp1086532120-2545) [ 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> 317046 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=2044) : 0 secs (null bytes/sec) to MockDirectoryWrapper(RAMDirectory@25b3659f lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@323dc274)
[junit4] 2> 317047 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=42, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=73.5322265625, floorSegmentMB=1.3017578125, forceMergeDeletesPctAllowed=24.218431441830756, segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.43833209798993233
[junit4] 2> 317047 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
[junit4] 2> 317047 INFO (indexFetcher-966-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@28769c58[collection1] main]
[junit4] 2> 317048 INFO (searcherExecutor-962-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@28769c58[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.3.0):c2)))}
[junit4] 2> 317053 INFO (qtp569339940-2564) [ x:collection1] o.a.s.c.S.Request [collection1] webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=2 status=0 QTime=0
[junit4] 2> 317053 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.h.TestReplicationHandler Waited for 400ms and found 2 docs
[junit4] 2> 317053 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestReplicateAfterCoreReload
[junit4] 2> 317054 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@2338735c{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 317054 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1677350301
[junit4] 2> 317054 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 317054 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@d562765: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@3a377fa5
[junit4] 2> 317058 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 317058 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@72828c2d: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 317061 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 317061 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@2f4e40d: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 317062 INFO (coreCloseExecutor-973-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@b44f3ed
[junit4] 2> 317062 INFO (coreCloseExecutor-973-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=189068269
[junit4] 2> 317062 INFO (coreCloseExecutor-973-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@44e3b971: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@472eaf0f
[junit4] 2> 317074 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5b54fab3{/solr,null,UNAVAILABLE}
[junit4] 2> 317075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@768ca4cc{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 317075 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=316609440
[junit4] 2> 317076 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 317076 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@74509893: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@73e203c1
[junit4] 2> 317081 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 317081 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6a1bf18f: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 317085 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 317086 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7b9d386b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 317086 INFO (coreCloseExecutor-975-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@7628dfcb
[junit4] 2> 317086 INFO (coreCloseExecutor-975-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1982390219
[junit4] 2> 317086 INFO (coreCloseExecutor-975-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@5e378a48: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@7b58c123
[junit4] 2> 317090 INFO (TEST-TestReplicationHandler.doTestReplicateAfterCoreReload-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7054a795{/solr,null,UNAVAILABLE}
[junit4] 2> 317093 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testRateLimitedReplication
[junit4] 2> 317093 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/collection1
[junit4] 2> 317095 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 317095 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@cbc7cde{/solr,null,AVAILABLE}
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@78f09c7c{HTTP/1.1,[http/1.1]}{127.0.0.1:40893}
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @319280ms
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/collection1/data, hostContext=/solr, hostPort=40893}
[junit4] 2> 317096 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:28.013Z
[junit4] 2> 317096 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/solr.xml
[junit4] 2> 317099 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 317099 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 317099 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 317117 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317122 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317122 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317123 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/.
[junit4] 2> 317123 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 317123 INFO (coreLoadExecutor-982-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 317134 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 317149 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 317151 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 317151 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/./collection1, trusted=true
[junit4] 2> 317151 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317151 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 317151 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/./collection1/data/]
[junit4] 2> 317153 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=16, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=24.66015625, floorSegmentMB=0.2841796875, forceMergeDeletesPctAllowed=25.47319963427799, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.11809655113127962
[junit4] 2> 317184 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 317184 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 317185 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=29, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
[junit4] 2> 317185 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@34a43261[collection1] main]
[junit4] 2> 317185 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-003/collection1/conf
[junit4] 2> 317185 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
[junit4] 2> 317185 INFO (coreLoadExecutor-982-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 317186 INFO (searcherExecutor-983-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@34a43261[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 317187 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/collection1
[junit4] 2> 317189 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 317191 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@3ef54b2b{/solr,null,AVAILABLE}
[junit4] 2> 317191 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6803f5ed{HTTP/1.1,[http/1.1]}{127.0.0.1:44945}
[junit4] 2> 317191 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.e.j.s.Server Started @319376ms
[junit4] 2> 317191 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {solr.data.dir=/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/collection1/data, hostContext=/solr, hostPort=44945}
[junit4] 2> 317191 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 317192 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.3.0
[junit4] 2> 317192 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standalone mode on port null
[junit4] 2> 317192 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 317192 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2017-12-23T17:50:28.109Z
[junit4] 2> 317192 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/solr.xml
[junit4] 2> 317195 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 317195 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 317196 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 317222 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317231 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317231 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317233 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/.
[junit4] 2> 317233 INFO (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 317233 INFO (coreLoadExecutor-992-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 317240 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.3.0
[junit4] 2> 317244 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 317245 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
[junit4] 2> 317245 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/./collection1, trusted=true
[junit4] 2> 317245 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@484a484c
[junit4] 2> 317245 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 317245 INFO (coreLoadExecutor-992-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001/solr-instance-004/./collection1/
[...truncated too long message...]
bapp=/solr path=/replication params={qt=/replication&wt=javabin&version=2&command=indexversion} status=0 QTime=0
[junit4] 2> 404193 INFO (searcherExecutor-1592-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@74cf8afe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 404193 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's generation: 1
[junit4] 2> 404193 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Master's version: 0
[junit4] 2> 404193 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's generation: 1
[junit4] 2> 404193 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.h.IndexFetcher Slave's version: 0
[junit4] 2> 404193 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.h.IndexFetcher New index in Master. Deleting mine...
[junit4] 2> 404194 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.SolrTestCaseJ4 ###Ending doTestHandlerPathUnchanged
[junit4] 2> 404194 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 404194 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@6b5cb1d9 commitCommandVersion:0
[junit4] 2> 404199 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@6a9e1e7e{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 404199 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1930158160
[junit4] 2> 404199 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 404199 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f7ba334: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4936e533
[junit4] 2> 404201 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 404201 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@7c96bb90: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 404202 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@155dbe27[collection1] main]
[junit4] 2> 404202 INFO (indexFetcher-1596-thread-1) [ x:collection1] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 404203 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 404203 INFO (searcherExecutor-1592-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@155dbe27[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 404203 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@77fdee4c: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 404207 INFO (coreCloseExecutor-1597-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@721fe782
[junit4] 2> 404207 INFO (coreCloseExecutor-1597-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1914693506
[junit4] 2> 404207 INFO (coreCloseExecutor-1597-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@674c0308: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@6f4452ea
[junit4] 2> 404213 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@d5e1238{/solr,null,UNAVAILABLE}
[junit4] 2> 404213 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@77692031{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 404213 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1668176837
[junit4] 2> 404213 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 404213 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3e411da: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@18e5bb03
[junit4] 2> 404216 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 404217 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@362d49f9: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@687867ef
[junit4] 2> 404219 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 404219 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@32668e41: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@3780627c
[junit4] 2> 404219 INFO (coreCloseExecutor-1599-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@54ae3130
[junit4] 2> 404219 INFO (coreCloseExecutor-1599-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=1420702000
[junit4] 2> 404220 INFO (coreCloseExecutor-1599-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@697781ea: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@4d3bbcb8
[junit4] 2> 404228 INFO (TEST-TestReplicationHandler.doTestHandlerPathUnchanged-seed#[A91EB842A762D22B]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@3b50ef16{/solr,null,UNAVAILABLE}
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A91EB842A762D22B-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {name=BlockTreeOrds(blocksize=128), id=BlockTreeOrds(blocksize=128), newname=BlockTreeOrds(blocksize=128)}, docValues:{}, maxPointsInLeafNode=169, maxMBSortInHeap=5.30698727386612, sim=RandomSimilarity(queryNorm=true): {}, locale=id-ID, timezone=Asia/Ulan_Bator
[junit4] 2> NOTE: Linux 4.10.0-40-generic amd64/Oracle Corporation 1.8.0_144 (64-bit)/cpus=8,threads=1,free=194381544,total=513277952
[junit4] 2> NOTE: All tests run in this JVM: [HdfsChaosMonkeyNothingIsSafeTest, TestSubQueryTransformer, TestAnalyzeInfixSuggestions, SolrMetricReporterTest, TestFoldingMultitermQuery, CleanupOldIndexTest, DocumentBuilderTest, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TestFieldCacheReopen, BigEndianAscendingWordDeserializerTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, QueryResultKeyTest, GraphQueryTest, TestFreeTextSuggestions, DeleteReplicaTest, TestIndexingPerformance, SyncSliceTest, TestSweetSpotSimilarityFactory, TestExactSharedStatsCache, RAMDirectoryFactoryTest, TestClusterProperties, SaslZkACLProviderTest, DateRangeFieldTest, TestComponentsName, HdfsNNFailoverTest, UpdateRequestProcessorFactoryTest, TestStressVersions, ResponseLogComponentTest, TestDistribStateManager, TestExpandComponent, OutOfBoxZkACLAndCredentialsProvidersTest, TestJsonFacetRefinement, AutoAddReplicasPlanActionTest, BaseCdcrDistributedZkTest, TestIBSimilarityFactory, NoCacheHeaderTest, TestReplicationHandler]
[junit4] Completed [124/764 (1!)] on J0 in 89.24s, 16 tests, 1 error, 1 skipped <<< FAILURES!
[...truncated 50178 lines...]