You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2016/12/20 17:49:03 UTC

[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+147) - Build # 18575 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18575/
Java: 32bit/jdk-9-ea+147 -server -XX:+UseSerialGC

4 tests failed.
FAILED:  org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication

Error Message:
expected:<1> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<1> but was:<0>
	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5:5F441F2605A1D923]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.junit.Assert.failNotEquals(Assert.java:647)
	at org.junit.Assert.assertEquals(Assert.java:128)
	at org.junit.Assert.assertEquals(Assert.java:472)
	at org.junit.Assert.assertEquals(Assert.java:456)
	at org.apache.solr.handler.TestReplicationHandler.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:1329)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  junit.framework.TestSuite.org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin

Error Message:
FIXME: SOLR-8182: This test fails under Java 9

Stack Trace:
com.carrotsearch.randomizedtesting.InternalAssumptionViolatedException: FIXME: SOLR-8182: This test fails under Java 9
	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5]:0)
	at com.carrotsearch.randomizedtesting.RandomizedTest.assumeTrue(RandomizedTest.java:667)
	at com.carrotsearch.randomizedtesting.RandomizedTest.assumeFalse(RandomizedTest.java:675)
	at org.apache.lucene.util.LuceneTestCase.assumeFalse(LuceneTestCase.java:850)
	at org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin.setupClass(TestSolrCloudWithHadoopAuthPlugin.java:45)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:847)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  junit.framework.TestSuite.org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin

Error Message:


Stack Trace:
java.lang.NullPointerException
	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5]:0)
	at org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin.tearDownClass(TestSolrCloudWithHadoopAuthPlugin.java:62)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.base/java.lang.Thread.run(Thread.java:844)


FAILED:  org.apache.solr.handler.admin.MetricsHandlerTest.test

Error Message:
Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @67f79f

Stack Trace:
java.lang.reflect.InaccessibleObjectException: Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @67f79f
	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5:2063CEA46DB51B3D]:0)
	at java.base/jdk.internal.reflect.Reflection.throwInaccessibleObjectException(Reflection.java:424)
	at java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:174)
	at java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
	at java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.invoke(FileDescriptorRatioGauge.java:48)
	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.getRatio(FileDescriptorRatioGauge.java:35)
	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:64)
	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:11)
	at org.apache.solr.util.stats.MetricUtils.gaugeToNamedList(MetricUtils.java:135)
	at org.apache.solr.util.stats.MetricUtils.lambda$toNamedList$2(MetricUtils.java:87)
	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184)
	at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:177)
	at java.base/java.util.TreeMap$KeySpliterator.forEachRemaining(TreeMap.java:2739)
	at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:484)
	at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
	at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151)
	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174)
	at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
	at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:430)
	at org.apache.solr.util.stats.MetricUtils.toNamedList(MetricUtils.java:80)
	at org.apache.solr.handler.admin.MetricsHandler.handleRequestBody(MetricsHandler.java:93)
	at org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:41)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 10824 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.MetricsHandlerTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_A837F17EC34976C5-001/init-core-data-001
   [junit4]   2> 145708 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 145710 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 145711 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 145797 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 145798 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 145817 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 145891 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 145893 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 145921 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 145922 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 145922 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 145925 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 145925 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 145925 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 145925 WARN  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 145925 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 145927 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 146029 WARN  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 146032 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 146068 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 146177 WARN  (coreLoadExecutor-574-thread-1) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 146180 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 146213 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 146214 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_A837F17EC34976C5-001/init-core-data-001/]
   [junit4]   2> 146214 WARN  (coreLoadExecutor-574-thread-1) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 146214 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 146215 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@ebeb3
   [junit4]   2> 146216 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=19, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0]
   [junit4]   2> 146240 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 146240 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 146240 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 146240 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 146241 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=42, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=74.5068359375, floorSegmentMB=0.970703125, forceMergeDeletesPctAllowed=21.482357411305333, segmentsPerTier=31.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.863278095937989
   [junit4]   2> 146241 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@161c2ae[collection1] main]
   [junit4]   2> 146242 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 146303 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 146544 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 146544 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 146545 INFO  (coreLoadExecutor-574-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554255650701180928
   [junit4]   2> 146545 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 146545 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 146545 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 146546 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 146546 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 146547 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 146547 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 146548 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 146548 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 146548 INFO  (searcherExecutor-575-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@161c2ae[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 146549 INFO  (TEST-MetricsHandlerTest.test-seed#[A837F17EC34976C5]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 146556 INFO  (TEST-MetricsHandlerTest.test-seed#[A837F17EC34976C5]) [    ] o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=MetricsHandlerTest -Dtests.method=test -Dtests.seed=A837F17EC34976C5 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lt-LT -Dtests.timezone=America/Fort_Wayne -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J2 | MetricsHandlerTest.test <<<
   [junit4]    > Throwable #1: java.lang.reflect.InaccessibleObjectException: Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @67f79f
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5:2063CEA46DB51B3D]:0)
   [junit4]    > 	at java.base/jdk.internal.reflect.Reflection.throwInaccessibleObjectException(Reflection.java:424)
   [junit4]    > 	at java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:174)
   [junit4]    > 	at java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
   [junit4]    > 	at java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
   [junit4]    > 	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.invoke(FileDescriptorRatioGauge.java:48)
   [junit4]    > 	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.getRatio(FileDescriptorRatioGauge.java:35)
   [junit4]    > 	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:64)
   [junit4]    > 	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:11)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.gaugeToNamedList(MetricUtils.java:135)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.lambda$toNamedList$2(MetricUtils.java:87)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184)
   [junit4]    > 	at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:177)
   [junit4]    > 	at java.base/java.util.TreeMap$KeySpliterator.forEachRemaining(TreeMap.java:2739)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:484)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
   [junit4]    > 	at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:430)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.toNamedList(MetricUtils.java:80)
   [junit4]    > 	at org.apache.solr.handler.admin.MetricsHandler.handleRequestBody(MetricsHandler.java:93)
   [junit4]    > 	at org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:41)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 146559 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 146559 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=14836724
   [junit4]   2> 146559 INFO  (coreCloseExecutor-580-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@13db549
   [junit4]   2> 146566 INFO  (coreCloseExecutor-580-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 146568 INFO  (SUITE-MetricsHandlerTest-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.handler.admin.MetricsHandlerTest_A837F17EC34976C5-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70), sim=RandomSimilarity(queryNorm=false): {}, locale=lt-LT, timezone=America/Fort_Wayne
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=40841200,total=173817856
   [junit4]   2> NOTE: All tests run in this JVM: [TestConfig, AnalysisErrorHandlingTest, CollectionStateFormat2Test, ShowFileRequestHandlerTest, CleanupOldIndexTest, AssignTest, RequestLoggingTest, TestCloudDeleteByQuery, TestFieldTypeResource, CollectionsAPISolrJTest, TestInitParams, SolrJmxReporterTest, OutOfBoxZkACLAndCredentialsProvidersTest, BlockCacheTest, TestAuthorizationFramework, XmlUpdateRequestHandlerTest, HdfsBasicDistributedZk2Test, SolrTestCaseJ4Test, MetricsHandlerTest]
   [junit4] Completed [52/669 (1!)] on J2 in 0.88s, 1 test, 1 error <<< FAILURES!

[...truncated 617 lines...]
   [junit4] Suite: org.apache.solr.handler.TestReplicationHandler
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/init-core-data-001
   [junit4]   2> 844230 INFO  (SUITE-TestReplicationHandler-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None")
   [junit4]   2> 844231 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.SolrTestCaseJ4 ###Starting testRateLimitedReplication
   [junit4]   2> 844232 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1
   [junit4]   2> 844236 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 844237 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1851b96{/solr,null,AVAILABLE}
   [junit4]   2> 844237 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@21eef{HTTP/1.1,[http/1.1]}{127.0.0.1:36276}
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server Started @845914ms
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/data, hostPort=36276}
   [junit4]   2> 844238 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 844238 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-20T17:19:52.747545Z
   [junit4]   2> 844239 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/solr.xml
   [junit4]   2> 844254 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/.
   [junit4]   2> 844255 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 844260 WARN  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 844261 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 844277 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 844278 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 844278 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1
   [junit4]   2> 844279 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 844280 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=55.37890625, floorSegmentMB=0.8154296875, forceMergeDeletesPctAllowed=16.511608687924053, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 844287 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 844287 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 844287 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=8, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 844287 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@160eba8[collection1] main]
   [junit4]   2> 844288 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/conf
   [junit4]   2> 844288 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.h.ReplicationHandler Replication enabled for following config files: schema.xml,xslt/dummy.xsl
   [junit4]   2> 844288 INFO  (coreLoadExecutor-2135-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 844288 INFO  (searcherExecutor-2136-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@160eba8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 844545 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1
   [junit4]   2> 844549 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 844550 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@9904e{/solr,null,AVAILABLE}
   [junit4]   2> 844550 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@11d62f1{HTTP/1.1,[http/1.1]}{127.0.0.1:43656}
   [junit4]   2> 844550 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server Started @846227ms
   [junit4]   2> 844550 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/data, hostPort=43656}
   [junit4]   2> 844551 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 844551 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 844551 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 844551 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 844551 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-20T17:19:53.060400Z
   [junit4]   2> 844551 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/solr.xml
   [junit4]   2> 844577 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/.
   [junit4]   2> 844577 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 844586 WARN  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 844587 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 844614 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 844615 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 844616 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/./collection1
   [junit4]   2> 844617 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 844618 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=13, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=55.37890625, floorSegmentMB=0.8154296875, forceMergeDeletesPctAllowed=16.511608687924053, segmentsPerTier=40.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
   [junit4]   2> 844628 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 844628 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 844628 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=8, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0]
   [junit4]   2> 844629 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c5e2da[collection1] main]
   [junit4]   2> 844629 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/conf
   [junit4]   2> 844632 INFO  (coreLoadExecutor-2145-thread-1) [    ] o.a.s.h.ReplicationHandler Poll scheduled at an interval of 1000ms
   [junit4]   2> 844632 INFO  (searcherExecutor-2146-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c5e2da[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 844640 INFO  (qtp23786072-4547) [    ] 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> 844640 INFO  (indexFetcher-2150-thread-1) [    ] o.a.s.h.IndexFetcher Master's generation: 1
   [junit4]   2> 844640 INFO  (indexFetcher-2150-thread-1) [    ] o.a.s.h.IndexFetcher Master's version: 0
   [junit4]   2> 844640 INFO  (indexFetcher-2150-thread-1) [    ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 844915 INFO  (qtp23786072-4549) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 844915 INFO  (qtp23786072-4549) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 844916 INFO  (qtp23455780-4564) [    ] o.a.s.u.DirectUpdateHandler2 [collection1] REMOVING ALL DOCUMENTS FROM INDEX
   [junit4]   2> 844916 INFO  (qtp23455780-4564) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{deleteByQuery=*:*} 0 0
   [junit4]   2> 844917 INFO  (qtp23786072-4542) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 844917 INFO  (qtp23786072-4542) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@10534db
   [junit4]   2> 844918 INFO  (qtp23786072-4542) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1419d8b[collection1] main]
   [junit4]   2> 844918 INFO  (qtp23786072-4542) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 844918 INFO  (searcherExecutor-2136-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1419d8b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 844918 INFO  (qtp23786072-4542) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 844918 INFO  (qtp23455780-4565) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 844918 INFO  (qtp23455780-4565) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@699382
   [junit4]   2> 844919 INFO  (qtp23455780-4565) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1936ec4[collection1] main]
   [junit4]   2> 844919 INFO  (qtp23455780-4565) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 844919 INFO  (searcherExecutor-2146-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1936ec4[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 844919 INFO  (qtp23455780-4565) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 1
   [junit4]   2> 844920 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@21eef{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 844920 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=1032550
   [junit4]   2> 844920 INFO  (coreCloseExecutor-2151-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@11ab9ea
   [junit4]   2> 844921 INFO  (coreCloseExecutor-2151-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 844921 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 844921 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@1851b96{/solr,null,UNAVAILABLE}
   [junit4]   2> 844923 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@11d62f1{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 844923 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=16130742
   [junit4]   2> 844927 INFO  (coreCloseExecutor-2153-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@e929d6
   [junit4]   2> 844927 INFO  (coreCloseExecutor-2153-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 844928 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 844928 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@9904e{/solr,null,UNAVAILABLE}
   [junit4]   2> 844930 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 844931 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@fef9bf{/solr,null,AVAILABLE}
   [junit4]   2> 844931 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1205e71{HTTP/1.1,[http/1.1]}{127.0.0.1:40854}
   [junit4]   2> 844931 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server Started @846608ms
   [junit4]   2> 844931 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/data, hostPort=40854}
   [junit4]   2> 844932 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 844932 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 844932 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 844932 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 844932 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-20T17:19:53.441428Z
   [junit4]   2> 844932 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/solr.xml
   [junit4]   2> 844950 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/.
   [junit4]   2> 844951 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 844956 WARN  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 844971 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 844977 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 844978 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 844978 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1
   [junit4]   2> 844978 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 844987 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7481573071080708]
   [junit4]   2> 845027 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 845027 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 845028 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5430342890065633]
   [junit4]   2> 845028 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@c1fdbb[collection1] main]
   [junit4]   2> 845029 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/conf
   [junit4]   2> 845029 INFO  (coreLoadExecutor-2160-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 845029 INFO  (searcherExecutor-2161-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@c1fdbb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 845240 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[0]} 0 0
   [junit4]   2> 845241 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[1]} 0 0
   [junit4]   2> 845242 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[2]} 0 0
   [junit4]   2> 845242 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[3]} 0 0
   [junit4]   2> 845244 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[4]} 0 0
   [junit4]   2> 845245 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[5]} 0 0
   [junit4]   2> 845246 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[6]} 0 0
   [junit4]   2> 845247 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[7]} 0 0
   [junit4]   2> 845248 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[8]} 0 0
   [junit4]   2> 845249 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[9]} 0 0
   [junit4]   2> 845250 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[10]} 0 0
   [junit4]   2> 845250 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[11]} 0 0
   [junit4]   2> 845251 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[12]} 0 0
   [junit4]   2> 845251 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[13]} 0 0
   [junit4]   2> 845252 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[14]} 0 0
   [junit4]   2> 845253 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[15]} 0 0
   [junit4]   2> 845253 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[16]} 0 0
   [junit4]   2> 845254 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[17]} 0 0
   [junit4]   2> 845254 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[18]} 0 0
   [junit4]   2> 845255 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[19]} 0 0
   [junit4]   2> 845256 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[20]} 0 0
   [junit4]   2> 845257 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[21]} 0 0
   [junit4]   2> 845257 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[22]} 0 0
   [junit4]   2> 845258 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[23]} 0 0
   [junit4]   2> 845258 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[24]} 0 0
   [junit4]   2> 845259 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[25]} 0 0
   [junit4]   2> 845260 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[26]} 0 0
   [junit4]   2> 845260 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[27]} 0 0
   [junit4]   2> 845261 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[28]} 0 0
   [junit4]   2> 845261 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[29]} 0 0
   [junit4]   2> 845262 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[30]} 0 0
   [junit4]   2> 845262 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[31]} 0 0
   [junit4]   2> 845262 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[32]} 0 0
   [junit4]   2> 845263 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[33]} 0 0
   [junit4]   2> 845264 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[34]} 0 0
   [junit4]   2> 845264 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[35]} 0 0
   [junit4]   2> 845265 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[36]} 0 0
   [junit4]   2> 845265 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[37]} 0 0
   [junit4]   2> 845265 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[38]} 0 0
   [junit4]   2> 845266 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[39]} 0 0
   [junit4]   2> 845267 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[40]} 0 0
   [junit4]   2> 845267 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[41]} 0 0
   [junit4]   2> 845268 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[42]} 0 0
   [junit4]   2> 845268 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[43]} 0 0
   [junit4]   2> 845269 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[44]} 0 0
   [junit4]   2> 845269 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[45]} 0 0
   [junit4]   2> 845270 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[46]} 0 0
   [junit4]   2> 845270 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[47]} 0 0
   [junit4]   2> 845271 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[48]} 0 0
   [junit4]   2> 845272 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[49]} 0 0
   [junit4]   2> 845272 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[50]} 0 0
   [junit4]   2> 845273 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[51]} 0 0
   [junit4]   2> 845273 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[52]} 0 0
   [junit4]   2> 845275 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[53]} 0 1
   [junit4]   2> 845275 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[54]} 0 0
   [junit4]   2> 845276 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[55]} 0 0
   [junit4]   2> 845276 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[56]} 0 0
   [junit4]   2> 845276 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[57]} 0 0
   [junit4]   2> 845277 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[58]} 0 0
   [junit4]   2> 845277 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[59]} 0 0
   [junit4]   2> 845279 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[60]} 0 0
   [junit4]   2> 845279 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[61]} 0 0
   [junit4]   2> 845280 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[62]} 0 0
   [junit4]   2> 845281 INFO  (qtp13667399-4590) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[63]} 0 0
   [junit4]   2> 845281 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[64]} 0 0
   [junit4]   2> 845282 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[65]} 0 0
   [junit4]   2> 845283 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[66]} 0 0
   [junit4]   2> 845284 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[67]} 0 0
   [junit4]   2> 845285 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[68]} 0 0
   [junit4]   2> 845286 INFO  (qtp13667399-4593) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[69]} 0 0
   [junit4]   2> 845286 INFO  (qtp13667399-4592) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[70]} 0 0
   [junit4]   2> 845287 INFO  (qtp13667399-4583) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[71]} 0 0
   [junit4]   2> 845288 INFO  (qtp13667399-4588) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[72]} 0 0
   [junit4]   2> 845288 INFO  (qtp13667399-4594) [    ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 845288 INFO  (qtp13667399-4594) [    ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@1625d76
   [junit4]   2> 845411 INFO  (qtp13667399-4594) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@13b02f6[collection1] main]
   [junit4]   2> 845411 INFO  (qtp13667399-4594) [    ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 845411 INFO  (searcherExecutor-2161-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@13b02f6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c73)))}
   [junit4]   2> 845411 INFO  (qtp13667399-4594) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={waitSearcher=true&commit=true&softCommit=false&wt=javabin&version=2}{commit=} 0 122
   [junit4]   2> 845412 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Stopped ServerConnector@1205e71{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 845412 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=21514107
   [junit4]   2> 845412 INFO  (coreCloseExecutor-2165-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1e7a1b0
   [junit4]   2> 845413 INFO  (coreCloseExecutor-2165-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 845413 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 845413 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@fef9bf{/solr,null,UNAVAILABLE}
   [junit4]   2> 845415 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 845416 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1b13a43{/solr,null,AVAILABLE}
   [junit4]   2> 845416 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@1b460d1{HTTP/1.1,[http/1.1]}{127.0.0.1:38459}
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server Started @847093ms
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/data, hostPort=38459}
   [junit4]   2> 845417 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-20T17:19:53.926428Z
   [junit4]   2> 845417 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/solr.xml
   [junit4]   2> 845428 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/.
   [junit4]   2> 845428 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 845433 WARN  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 845434 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 845439 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 845440 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 845441 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1
   [junit4]   2> 845441 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/./collection1/data/]
   [junit4]   2> 845451 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 845451 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 845452 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7481573071080708]
   [junit4]   2> 845454 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f33c30[collection1] main]
   [junit4]   2> 845454 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-001/collection1/conf
   [junit4]   2> 845455 INFO  (coreLoadExecutor-2172-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 845455 INFO  (searcherExecutor-2173-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f33c30[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c73)))}
   [junit4]   2> 845741 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4d888c{/solr,null,AVAILABLE}
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.AbstractConnector Started ServerConnector@860cf0{HTTP/1.1,[http/1.1]}{127.0.0.1:39717}
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.Server Started @847419ms
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/data, hostPort=39717}
   [junit4]   2> 845742 ERROR (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr™ version 7.0.0
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on port null
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 845742 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2016-12-20T17:19:54.251939Z
   [junit4]   2> 845743 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/solr.xml
   [junit4]   2> 845753 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/.
   [junit4]   2> 845753 INFO  (TEST-TestReplicationHandler.testRateLimitedReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 845758 WARN  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
   [junit4]   2> 845758 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 845764 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 845765 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.2 with uniqueid field id
   [junit4]   2> 845765 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/./collection1
   [junit4]   2> 845766 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/./collection1/data/]
   [junit4]   2> 845783 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7481573071080708]
   [junit4]   2> 845843 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 845843 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 845843 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5430342890065633]
   [junit4]   2> 845844 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@1a72de[collection1] main]
   [junit4]   2> 845844 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.r.ManagedResourceStorage File-based storage initialized to use dir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/conf
   [junit4]   2> 845844 INFO  (coreLoadExecutor-2182-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 845844 INFO  (searcherExecutor-2183-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1a72de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 846026 WARN  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher 'masterUrl' must be specified without the /replication suffix
   [junit4]   2> 846029 INFO  (qtp13086760-4611) [    ] 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> 846029 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's generation: 2
   [junit4]   2> 846029 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Master's version: 1482254393797
   [junit4]   2> 846029 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Slave's generation: 1
   [junit4]   2> 846029 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting replication process
   [junit4]   2> 846031 INFO  (qtp13086760-4612) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&wt=javabin&version=2&command=filelist} status=0 QTime=1
   [junit4]   2> 846031 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Number of files in latest index in master: 4
   [junit4]   2> 846033 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.7481573071080708]
   [junit4]   2> 846033 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 846034 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Starting download (fullCopy=false) to NRTCachingDirectory(NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/data/index.20161220121954540 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@93b46; maxCacheMB=48.0 maxMergeSizeMB=4.0)
   [junit4]   2> 846034 INFO  (qtp13086760-4613) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.cfe&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 846036 INFO  (qtp13086760-4606) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.si&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 846038 INFO  (qtp13086760-4611) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={generation=2&qt=/replication&file=_0.cfs&checksum=true&wt=filestream&command=filecontent} status=0 QTime=0
   [junit4]   2> 850221 INFO  (qtp13086760-4612) [    ] 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> 850222 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.h.IndexFetcher Total time taken for download (fullCopy=false,bytesDownloaded=439145) : 4 secs (109786 bytes/sec) to NRTCachingDirectory(NIOFSDirectory@/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001/solr-instance-002/collection1/data/index.20161220121954540 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@93b46; maxCacheMB=48.0 maxMergeSizeMB=4.0)
   [junit4]   2> 850265 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=49, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.5430342890065633]
   [junit4]   2> 850266 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.u.DefaultSolrCoreState New IndexWriter is ready to be used.
   [junit4]   2> 850267 INFO  (explicit-fetchindex-cmd) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@fb1e62[collection1] main]
   [junit4]   2> 850267 INFO  (searcherExecutor-2183-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@fb1e62[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):c73)))}
   [junit4]   2> 850267 INFO  (qtp10504996-4628) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/replication params={wait=true&masterUrl=http://127.0.0.1:38459/solr/collection1/replication&command=fetchindex} status=0 QTime=4242
   [junit4]   2> 850279 INFO  (qtp13086760-4606) [    ] o.a.s.u.p.LogUpdateProcessorFactory [collection1]  webapp=/solr path=/update params={wt=javabin&version=2}{add=[73]} 0 0
   [junit4]   2> 850280 INFO  (qtp10504996-4630) [    ] o.a.s.c.S.Request [collection1]  webapp=/solr path=/select params={q=*:*&sort=id+desc&wt=javabin&version=2} hits=73 status=0 QTime=0
   [junit4]   2> 850280 INFO  (qtp13086760-4611) 

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

nnector Stopped ServerConnector@7d3220{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 938995 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2664567
   [junit4]   2> 938995 INFO  (coreCloseExecutor-2787-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@86a558
   [junit4]   2> 938995 INFO  (coreCloseExecutor-2787-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 938996 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[A837F17EC34976C5]) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> 938996 INFO  (TEST-TestReplicationHandler.doTestIndexAndConfigReplication-seed#[A837F17EC34976C5]) [    ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@72480d{/solr,null,UNAVAILABLE}
   [junit4]   2> 938997 INFO  (SUITE-TestReplicationHandler-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.TestReplicationHandler_A837F17EC34976C5-001
   [junit4]   2> NOTE: test params are: codec=CheapBastard, sim=RandomSimilarity(queryNorm=false): {}, locale=fr-BI, timezone=America/Jamaica
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=132395880,total=392818688
   [junit4]   2> NOTE: All tests run in this JVM: [SolrCoreTest, TestFreeTextSuggestions, AsyncCallRequestStatusResponseTest, XsltUpdateRequestHandlerTest, ActionThrottleTest, TestRandomFaceting, TestSolrCloudSnapshots, ShardSplitTest, TestSubQueryTransformerCrossCore, BasicDistributedZkTest, TestImplicitCoreProperties, TestSlowCompositeReaderWrapper, DistribDocExpirationUpdateProcessorTest, SolrRequestParserTest, TestDFRSimilarityFactory, TestBlobHandler, TestTolerantUpdateProcessorCloud, DisMaxRequestHandlerTest, TestSolrConfigHandlerConcurrent, BasicAuthStandaloneTest, PingRequestHandlerTest, AnalysisAfterCoreReloadTest, TestStressLucene, TestManagedSchema, TestOmitPositions, PeerSyncReplicationTest, SuggestComponentContextFilterQueryTest, TestReplicationHandler]
   [junit4] Completed [247/669 (2!)] on J0 in 94.78s, 15 tests, 1 failure, 1 skipped <<< FAILURES!

[...truncated 1261 lines...]
   [junit4] Suite: org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin_A837F17EC34976C5-001/init-core-data-001
   [junit4]   2> 2039748 INFO  (SUITE-TestSolrCloudWithHadoopAuthPlugin-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 2039749 INFO  (SUITE-TestSolrCloudWithHadoopAuthPlugin-seed#[A837F17EC34976C5]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=1474, maxMBSortInHeap=6.417686552295345, sim=RandomSimilarity(queryNorm=true): {}, locale=fr-TD, timezone=Pacific/Samoa
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=176948336,total=460832768
   [junit4]   2> NOTE: All tests run in this JVM: [TestConfig, AnalysisErrorHandlingTest, CollectionStateFormat2Test, ShowFileRequestHandlerTest, CleanupOldIndexTest, AssignTest, RequestLoggingTest, TestCloudDeleteByQuery, TestFieldTypeResource, CollectionsAPISolrJTest, TestInitParams, SolrJmxReporterTest, OutOfBoxZkACLAndCredentialsProvidersTest, BlockCacheTest, TestAuthorizationFramework, XmlUpdateRequestHandlerTest, HdfsBasicDistributedZk2Test, SolrTestCaseJ4Test, MetricsHandlerTest, SuggesterTSTTest, TestRestoreCore, EchoParamsTest, TestSortByMinMaxFunction, TestManagedSchemaThreadSafety, TestCollationFieldDocValues, TestUseDocValuesAsStored2, SharedFSAutoReplicaFailoverUtilsTest, CheckHdfsIndexTest, CoreAdminRequestStatusTest, AtomicUpdatesTest, RestartWhileUpdatingTest, SaslZkACLProviderTest, TestSolrXml, OverseerModifyCollectionTest, PrimUtilsTest, TestIndexSearcher, FieldMutatingUpdateProcessorTest, TestIBSimilarityFactory, TestFieldCacheSort, TestRebalanceLeaders, TestUtils, TestZkChroot, TestDefaultSearchFieldResource, ForceLeaderTest, DeleteInactiveReplicaTest, TestMiniSolrCloudCluster, TestFieldCollectionResource, SimpleFacetsTest, TestFieldCache, TestTolerantSearch, TestFieldSortValues, TestFastOutputStream, DirectUpdateHandlerTest, FullSolrCloudDistribCmdsTest, SolrMetricManagerTest, SpatialHeatmapFacetsTest, RequestHandlersTest, TestExportWriter, UpdateParamsTest, OutputWriterTest, TestDistributedStatsComponentCardinality, TestMacroExpander, TestFieldCacheWithThreads, TestSolrConfigHandlerCloud, DistributedQueueTest, UnloadDistributedZkTest, TestQuerySenderNoQuery, TestSha256AuthenticationProvider, TestTrackingShardHandlerFactory, IgnoreCommitOptimizeUpdateProcessorFactoryTest, RAMDirectoryFactoryTest, BlobRepositoryCloudTest, HighlighterConfigTest, PeerSyncWithIndexFingerprintCachingTest, TestPhraseSuggestions, TestShardHandlerFactory, TestCoreDiscovery, HLLSerializationTest, TestSolrDeletionPolicy1, HdfsDirectoryTest, HdfsDirectoryFactoryTest, FieldAnalysisRequestHandlerTest, TestReversedWildcardFilterFactory, DeleteReplicaTest, TestNumericTerms64, TestCollapseQParserPlugin, TestSolrQueryParserDefaultOperatorResource, TestFileDictionaryLookup, TestReload, HdfsSyncSliceTest, LukeRequestHandlerTest, TestSubQueryTransformer, DistributedFacetPivotSmallAdvancedTest, LeaderFailoverAfterPartitionTest, TestDocSet, CdcrRequestHandlerTest, BooleanFieldTest, CircularListTest, TestJsonFacets, TestOverriddenPrefixQueryForCustomFieldType, SolrCloudExampleTest, SynonymTokenizerTest, TestExtendedDismaxParser, TestScoreJoinQPNoScore, DateFieldTest, TestDistributedMissingSort, TestIndexingPerformance, TestXmlQParser, CurrencyFieldXmlFileTest, SuggesterWFSTTest, OverseerTest, ShardRoutingTest, RecoveryZkTest, LeaderElectionTest, ZkCLITest, AutoCommitTest, TestFaceting, TestRecovery, DistributedSpellCheckComponentTest, ZkControllerTest, TestRealTimeGet, TestStressReorder, HardAutoCommitTest, TestRangeQuery, SimplePostToolTest, CoreAdminHandlerTest, TestFoldingMultitermQuery, SuggesterTest, PolyFieldTest, SchemaVersionSpecificBehaviorTest, DirectUpdateHandlerOptimizeTest, DefaultValueUpdateProcessorTest, SortByFunctionTest, TestRemoteStreaming, DebugComponentTest, IndexBasedSpellCheckerTest, TestWriterPerf, PrimitiveFieldTypeTest, PathHierarchyTokenizerFactoryTest, TestSolrQueryParser, RegexBoostProcessorTest, IndexSchemaTest, TestCollationField, UpdateRequestProcessorFactoryTest, MBeansHandlerTest, UniqFieldsUpdateProcessorFactoryTest, TestPartialUpdateDeduplication, TestComponentsName, TestLFUCache, PreAnalyzedFieldTest, TestSystemIdResolver, TestSolrJ, TestLRUCache, ZkNodePropsTest, SliceStateTest, SystemInfoHandlerTest, UUIDFieldTest, DistributedMLTComponentTest, TestRTGBase, TestCrossCoreJoin, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, CdcrBootstrapTest, TestCloudPseudoReturnFields, TestCollectionAPI, TestDownShardTolerantSearch, TestHdfsCloudBackupRestore, TestLeaderElectionZkExpiry, TestLeaderInitiatedRecoveryThread, TestOnReconnectListenerSupport, TestReplicaProperties, TestSizeLimitedDistributedMap, TestSolrCloudWithKerberosAlt, TestStressCloudBlindAtomicUpdates, TlogReplayBufferedWhileIndexingTest, TriLevelCompositeIdRoutingTest, CachingDirectoryFactoryTest, TestConfigOverlay, TestConfigSetProperties, TestConfigSets, TestDynamicLoading, CoreMergeIndexesAdminHandlerTest, StatsReloadRaceTest, DistributedFacetExistsSmallTest, DistributedFacetPivotSmallTest, DistributedQueryComponentCustomSortTest, SolrCoreMetricManagerTest, TestBinaryResponseWriter, TestJavabinTupleStreamParser, TestRawTransformer, TestManagedResource, TestBulkSchemaAPI, TestBulkSchemaConcurrent, SortSpecParsingTest, TestComplexPhraseQParserPlugin, TestCustomSort, TestHashQParserPlugin, TestMaxScoreQueryParser, TestNoOpRegenerator, TestQueryWrapperFilter, TestReRankQParserPlugin, TestRecoveryHdfs, TestReloadDeadlock, TestSearcherReuse, TestSolrFieldCacheMBean, TestStandardQParsers, TestStressUserVersions, TestXmlQParserPlugin, BJQParserTest, GraphQueryTest, CloudMLTQParserTest, TestExactSharedStatsCache, TestLRUStatsCache, TestSolrCloudWithHadoopAuthPlugin]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestSolrCloudWithHadoopAuthPlugin -Dtests.seed=A837F17EC34976C5 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr-TD -Dtests.timezone=Pacific/Samoa -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.00s J2 | TestSolrCloudWithHadoopAuthPlugin (suite) <<<
   [junit4]    > Assumption #1: FIXME: SOLR-8182: This test fails under Java 9Throwable #2: java.lang.NullPointerException
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([A837F17EC34976C5]:0)
   [junit4]    > 	at org.apache.solr.security.hadoop.TestSolrCloudWithHadoopAuthPlugin.tearDownClass(TestSolrCloudWithHadoopAuthPlugin.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [638/669 (3!)] on J2 in 0.03s, 0 tests, 1 error <<< FAILURES!

[...truncated 51588 lines...]


[JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+147) - Build # 18576 - Still Unstable!

Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/18576/
Java: 32bit/jdk-9-ea+147 -client -XX:+UseParallelGC

1 tests failed.
FAILED:  org.apache.solr.handler.admin.MetricsHandlerTest.test

Error Message:
Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @1a5db8e

Stack Trace:
java.lang.reflect.InaccessibleObjectException: Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @1a5db8e
	at __randomizedtesting.SeedInfo.seed([DBD49BD6595B7890:5380A40CF7A71568]:0)
	at java.base/jdk.internal.reflect.Reflection.throwInaccessibleObjectException(Reflection.java:424)
	at java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:174)
	at java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
	at java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.invoke(FileDescriptorRatioGauge.java:48)
	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.getRatio(FileDescriptorRatioGauge.java:35)
	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:64)
	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:11)
	at org.apache.solr.util.stats.MetricUtils.gaugeToNamedList(MetricUtils.java:135)
	at org.apache.solr.util.stats.MetricUtils.lambda$toNamedList$2(MetricUtils.java:87)
	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184)
	at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:177)
	at java.base/java.util.TreeMap$KeySpliterator.forEachRemaining(TreeMap.java:2739)
	at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:484)
	at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
	at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151)
	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174)
	at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
	at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:430)
	at org.apache.solr.util.stats.MetricUtils.toNamedList(MetricUtils.java:80)
	at org.apache.solr.handler.admin.MetricsHandler.handleRequestBody(MetricsHandler.java:93)
	at org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:41)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
	at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 12383 lines...]
   [junit4] Suite: org.apache.solr.handler.admin.MetricsHandlerTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.MetricsHandlerTest_DBD49BD6595B7890-001/init-core-data-001
   [junit4]   2> 1802910 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason="", ssl=0.0/0.0, value=0.0/0.0, clientAuth=0.0/0.0)
   [junit4]   2> 1802912 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 1802913 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1802996 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1803025 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.s.IndexSchema [null] Schema name=test
   [junit4]   2> 1803097 WARN  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.s.IndexSchema [null] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1803099 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1803124 WARN  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 1803136 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803136 WARN  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 1803140 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803141 WARN  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 1803141 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803141 WARN  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 1803141 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803143 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
   [junit4]   2> 1803215 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1803239 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.s.IndexSchema [collection1] Schema name=test
   [junit4]   2> 1803315 WARN  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.s.IndexSchema [collection1] default search field in schema is text. WARNING: Deprecated, please use 'df' on request instead.
   [junit4]   2> 1803317 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
   [junit4]   2> 1803334 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1
   [junit4]   2> 1803335 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.MetricsHandlerTest_DBD49BD6595B7890-001/init-core-data-001/]
   [junit4]   2> 1803335 WARN  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.m.r.SolrJmxReporter No serviceUrl or agentId was configured, using first MBeanServer.
   [junit4]   2> 1803335 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.m.r.SolrJmxReporter JMX monitoring enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803336 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@15274b0
   [junit4]   2> 1803337 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@ce5fc0
   [junit4]   2> 1803356 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 1803356 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 1803357 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 1803357 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 1803357 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=36, maxMergeAtOnceExplicit=49, maxMergedSegmentMB=42.240234375, floorSegmentMB=0.2705078125, forceMergeDeletesPctAllowed=11.320694124382648, segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4524016981062845
   [junit4]   2> 1803357 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.s.SolrIndexSearcher Opening [Searcher@a5ebab[collection1] main]
   [junit4]   2> 1803357 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 1803401 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.s.DirectSolrSpellChecker init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3}
   [junit4]   2> 1803631 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 1803632 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 1803632 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: direct
   [junit4]   2> 1803632 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 1803632 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: multipleFields
   [junit4]   2> 1803632 INFO  (coreLoadExecutor-7609-thread-1) [    ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1554268585826713600
   [junit4]   2> 1803633 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: jarowinkler
   [junit4]   2> 1803633 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: external
   [junit4]   2> 1803633 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: freq
   [junit4]   2> 1803634 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: fqcn
   [junit4]   2> 1803634 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: perDict
   [junit4]   2> 1803635 INFO  (searcherExecutor-7610-thread-1) [    ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@a5ebab[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 1803636 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 1803638 INFO  (TEST-MetricsHandlerTest.test-seed#[DBD49BD6595B7890]) [    ] o.a.s.SolrTestCaseJ4 ###Starting test
   [junit4]   2> 1803648 INFO  (TEST-MetricsHandlerTest.test-seed#[DBD49BD6595B7890]) [    ] o.a.s.SolrTestCaseJ4 ###Ending test
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=MetricsHandlerTest -Dtests.method=test -Dtests.seed=DBD49BD6595B7890 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=lrc-IR -Dtests.timezone=Asia/Pontianak -Dtests.asserts=true -Dtests.file.encoding=UTF-8
   [junit4] ERROR   0.01s J0 | MetricsHandlerTest.test <<<
   [junit4]    > Throwable #1: java.lang.reflect.InaccessibleObjectException: Unable to make member of class com.sun.management.internal.OperatingSystemImpl accessible:  module jdk.management does not export com.sun.management.internal to unnamed module @1a5db8e
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([DBD49BD6595B7890:5380A40CF7A71568]:0)
   [junit4]    > 	at java.base/jdk.internal.reflect.Reflection.throwInaccessibleObjectException(Reflection.java:424)
   [junit4]    > 	at java.base/java.lang.reflect.AccessibleObject.checkCanSetAccessible(AccessibleObject.java:174)
   [junit4]    > 	at java.base/java.lang.reflect.Method.checkCanSetAccessible(Method.java:192)
   [junit4]    > 	at java.base/java.lang.reflect.Method.setAccessible(Method.java:186)
   [junit4]    > 	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.invoke(FileDescriptorRatioGauge.java:48)
   [junit4]    > 	at com.codahale.metrics.jvm.FileDescriptorRatioGauge.getRatio(FileDescriptorRatioGauge.java:35)
   [junit4]    > 	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:64)
   [junit4]    > 	at com.codahale.metrics.RatioGauge.getValue(RatioGauge.java:11)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.gaugeToNamedList(MetricUtils.java:135)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.lambda$toNamedList$2(MetricUtils.java:87)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.accept(ForEachOps.java:184)
   [junit4]    > 	at java.base/java.util.stream.ReferencePipeline$2$1.accept(ReferencePipeline.java:177)
   [junit4]    > 	at java.base/java.util.TreeMap$KeySpliterator.forEachRemaining(TreeMap.java:2739)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.copyInto(AbstractPipeline.java:484)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.wrapAndCopyInto(AbstractPipeline.java:474)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp.evaluateSequential(ForEachOps.java:151)
   [junit4]    > 	at java.base/java.util.stream.ForEachOps$ForEachOp$OfRef.evaluateSequential(ForEachOps.java:174)
   [junit4]    > 	at java.base/java.util.stream.AbstractPipeline.evaluate(AbstractPipeline.java:234)
   [junit4]    > 	at java.base/java.util.stream.ReferencePipeline.forEach(ReferencePipeline.java:430)
   [junit4]    > 	at org.apache.solr.util.stats.MetricUtils.toNamedList(MetricUtils.java:80)
   [junit4]    > 	at org.apache.solr.handler.admin.MetricsHandler.handleRequestBody(MetricsHandler.java:93)
   [junit4]    > 	at org.apache.solr.handler.admin.MetricsHandlerTest.test(MetricsHandlerTest.java:41)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:538)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4]   2> 1803651 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> 1803651 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=9276721
   [junit4]   2> 1803651 INFO  (coreCloseExecutor-7615-thread-1) [    ] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@1ff72dd
   [junit4]   2> 1803658 INFO  (coreCloseExecutor-7615-thread-1) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.core.collection1
   [junit4]   2> 1803662 INFO  (SUITE-MetricsHandlerTest-seed#[DBD49BD6595B7890]-worker) [    ] o.a.s.m.SolrMetricManager Closing metric reporters for: solr.node
   [junit4]   2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J0/temp/solr.handler.admin.MetricsHandlerTest_DBD49BD6595B7890-001
   [junit4]   2> NOTE: test params are: codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY, chunkSize=15529, maxDocsPerChunk=6, blockSize=9), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, chunkSize=15529, blockSize=9)), sim=RandomSimilarity(queryNorm=false): {}, locale=lrc-IR, timezone=Asia/Pontianak
   [junit4]   2> NOTE: Linux 4.4.0-53-generic i386/Oracle Corporation 9-ea (32-bit)/cpus=12,threads=1,free=184495472,total=390594560
   [junit4]   2> NOTE: All tests run in this JVM: [PeerSyncReplicationTest, TestFaceting, TestManagedSchema, TestXmlQParserPlugin, TestConfigSetsAPI, DeleteLastCustomShardedReplicaTest, TestSlowCompositeReaderWrapper, TestCSVLoader, StandardRequestHandlerTest, TestReplicationHandlerBackup, DefaultValueUpdateProcessorTest, UniqFieldsUpdateProcessorFactoryTest, TestPseudoReturnFields, DocumentAnalysisRequestHandlerTest, TestFilteredDocIdSet, DirectoryFactoryTest, SearchHandlerTest, SyncSliceTest, TestConfigSetImmutable, BJQParserTest, ZkStateReaderTest, HttpSolrCallGetCoreTest, CollectionTooManyReplicasTest, TestCryptoKeys, TestFieldCacheSortRandom, TestDocBasedVersionConstraints, CopyFieldTest, BlockJoinFacetSimpleTest, SuggestComponentContextFilterQueryTest, HdfsLockFactoryTest, TestRTGBase, TestLocalFSCloudBackupRestore, TestRandomFlRTGCloud, TestFoldingMultitermQuery, TestJoin, DistributedFacetPivotSmallTest, DistributedQueryComponentOptimizationTest, PathHierarchyTokenizerFactoryTest, SystemInfoHandlerTest, DeleteShardTest, NotRequiredUniqueKeyTest, HdfsRecoveryZkTest, TestSubQueryTransformerCrossCore, TestInitQParser, TestSearcherReuse, QueryResultKeyTest, TestFastWriter, CdcrVersionReplicationTest, TestCorePropertiesReload, PluginInfoTest, TestCodecSupport, PeerSyncTest, DistributedDebugComponentTest, MinimalSchemaTest, TestRealTimeGet, BasicZkTest, CurrencyFieldOpenExchangeTest, TestOmitPositions, BasicAuthStandaloneTest, ActionThrottleTest, TestSolrConfigHandler, TestUninvertingReader, BlockDirectoryTest, JavabinLoaderTest, SpellPossibilityIteratorTest, TestStressLucene, FileBasedSpellCheckerTest, TestJmxMonitoredMap, TestDistributedSearch, DistribDocExpirationUpdateProcessorTest, TestLMJelinekMercerSimilarityFactory, TestReplicationHandler, TestExactStatsCache, OverriddenZkACLAndCredentialsProvidersTest, TestEmbeddedSolrServerConstructors, TestBlobHandler, ReplaceNodeTest, OverseerRolesTest, TestAnalyzedSuggestions, TestSolrCoreProperties, TestFieldCacheReopen, TestNamedUpdateProcessors, TestSizeLimitedDistributedMap, TestPushWriter, SignatureUpdateProcessorFactoryTest, TestLeaderElectionWithEmptyReplica, TestPKIAuthenticationPlugin, RequiredFieldsTest, DistributedVersionInfoTest, MergeStrategyTest, CloneFieldUpdateProcessorFactoryTest, TestJmxIntegration, ZkNodePropsTest, TestLFUCache, XsltUpdateRequestHandlerTest, CreateCollectionCleanupTest, CdcrReplicationDistributedZkTest, TestSQLHandler, LeaderFailureAfterFreshStartTest, TestLazyCores, TestDynamicFieldCollectionResource, SolrMetricReporterTest, TestStressUserVersions, HLLUtilTest, TestBadConfig, CloudExitableDirectoryReaderTest, SecurityConfHandlerTest, AsyncCallRequestStatusResponseTest, LeaderElectionIntegrationTest, FullSolrCloudDistribCmdsTest, TestZkChroot, TestRecovery, TermVectorComponentDistributedTest, SimpleFacetsTest, TestSolr4Spatial, SolrCoreTest, SpellCheckComponentTest, QueryElevationComponentTest, BadIndexSchemaTest, TestFiltering, TestTrie, SuggesterWFSTTest, PolyFieldTest, NoCacheHeaderTest, SchemaVersionSpecificBehaviorTest, FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases, QueryEqualityTest, DistanceFunctionTest, SolrInfoMBeanTest, TestSurroundQueryParser, DocumentBuilderTest, TermVectorComponentTest, TestSolrQueryParser, IndexSchemaRuntimeFieldTest, TestCollationField, ReturnFieldsTest, PingRequestHandlerTest, TestSolrDeletionPolicy2, MultiTermTest, TestDocSet, TestBinaryField, TestSearchPerf, NumericFieldsTest, TestElisionMultitermQuery, TestConfig, OutputWriterTest, TestPostingsSolrHighlighter, DirectSolrConnectionTest, TestLuceneMatchVersion, SynonymTokenizerTest, TestXIncludeConfig, EchoParamsTest, TestDFRSimilarityFactory, TestPerFieldSimilarity, TestIBSimilarityFactory, TestFastOutputStream, OpenExchangeRatesOrgProviderTest, DateMathParserTest, TestSystemIdResolver, TestSuggestSpellingConverter, DateFieldTest, ClusterStateTest, TestLRUCache, CursorPagingTest, SolrTestCaseJ4Test, TestCrossCoreJoin, TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, AssignTest, CdcrReplicationHandlerTest, CollectionReloadTest, HttpPartitionTest, SolrXmlInZkTest, TestAuthenticationFramework, TestCloudPseudoReturnFields, TestCloudRecovery, TestDistribDocBasedVersion, TestMiniSolrCloudClusterSSL, TestSSLRandomization, TestSegmentSorting, TestSolrCloudWithDelegationTokens, TestSolrCloudWithSecureImpersonation, TestStressCloudBlindAtomicUpdates, TestTolerantUpdateProcessorCloud, TriLevelCompositeIdRoutingTest, HdfsDirectoryFactoryTest, TestBackupRepositoryFactory, TestImplicitCoreProperties, TestInfoStreamLogging, TestInitParams, TestNRTOpen, TestReloadAndDeleteDocs, TestSolrXml, TestSolrCloudSnapshots, MetricsHandlerTest]
   [junit4] Completed [536/669 (1!)] on J0 in 0.77s, 1 test, 1 error <<< FAILURES!

[...truncated 51892 lines...]