Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/3987/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC

3 tests failed.
FAILED:  org.apache.solr.metrics.JvmMetricsTest.testSetupJvmMetrics

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([8F621F0DA00D04EF:33D6C9B7B1BDCB8D]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.metrics.JvmMetricsTest.testSetupJvmMetrics(JvmMetricsTest.java:142)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  org.apache.solr.metrics.JvmMetricsTest.testSystemProperties

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([8F621F0DA00D04EF:E2CC8968D24B0C25]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertNotNull(Assert.java:526)
        at org.junit.Assert.assertNotNull(Assert.java:537)
        at 
org.apache.solr.metrics.JvmMetricsTest.testSystemProperties(JvmMetricsTest.java:107)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
        at java.lang.Thread.run(Thread.java:748)


FAILED:  
org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.testExplicitConfiguration

Error Message:
jvm.memory.heap.init

Stack Trace:
java.lang.AssertionError: jvm.memory.heap.init
        at 
__randomizedtesting.SeedInfo.seed([8F621F0DA00D04EF:CBAE3FF6CE37D285]:0)
        at org.junit.Assert.fail(Assert.java:93)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at 
org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.lambda$testExplicitConfiguration$0(SolrCloudReportersTest.java:133)
        at 
java.util.concurrent.CopyOnWriteArrayList.forEach(CopyOnWriteArrayList.java:890)
        at 
java.util.Collections$UnmodifiableCollection.forEach(Collections.java:1080)
        at 
org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest.testExplicitConfiguration(SolrCloudReportersTest.java:70)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java: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:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 11191 lines...]
   [junit4] Suite: org.apache.solr.metrics.JvmMetricsTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/init-core-data-001
   [junit4]   2> 818690 WARN  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 818690 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields
   [junit4]   2> 818694 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 819700 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore
   [junit4]   2> 819701 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ####initCore end
   [junit4]   2> 819702 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Writing core.properties file to 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-002/cores/core
   [junit4]   2> 819706 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] o.e.j.s.Server 
jetty-9.3.14.v20161028
   [junit4]   2> 819711 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@25b87ef7{/solr,null,AVAILABLE}
   [junit4]   2> 819715 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@19a3fffe{HTTP/1.1,[http/1.1]}{127.0.0.1:52652}
   [junit4]   2> 819716 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] o.e.j.s.Server 
Started @825426ms
   [junit4]   2> 819716 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=52652, 
configSetBaseDir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001,
 
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-002/cores}
   [junit4]   2> 819717 ERROR 
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 819717 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 819718 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in standalone mode on 
port null
   [junit4]   2> 819718 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 819718 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-05-04T13:58:40.871Z
   [junit4]   2> 819718 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.SolrXmlConfig Loading container configuration from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/solr.xml
   [junit4]   2> 819732 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 819849 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620
   [junit4]   2> 819849 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') 
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620
   [junit4]   2> 819849 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620
   [junit4]   2> 819890 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001
   [junit4]   2> 819890 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
   [junit4]   2> 819895 ERROR 
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.s.SolrDispatchFilter Could not start Solr. Check solr/home property and 
the logs
   [junit4]   2> 819896 ERROR 
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] o.a.s.c.SolrCore 
null:java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.setupJvmMetrics(SolrDispatchFilter.java:194)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:175)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:137)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1565)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1599)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1285)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1130)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:306)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:394)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:367)
   [junit4]   2>        at 
org.apache.solr.SolrJettyTestBase.createJetty(SolrJettyTestBase.java:114)
   [junit4]   2>        at 
org.apache.solr.SolrJettyTestBase.createJetty(SolrJettyTestBase.java:92)
   [junit4]   2>        at 
org.apache.solr.metrics.JvmMetricsTest.beforeTest(JvmMetricsTest.java:60)
   [junit4]   2>        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native 
Method)
   [junit4]   2>        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]   2>        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]   2>        at java.lang.reflect.Method.invoke(Method.java:498)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:847)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
   [junit4]   2>        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
   [junit4]   2>        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
   [junit4]   2>        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 819916 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/extraction/lib
 filtered by .*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/extraction/lib
   [junit4]   2> 819918 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
 filtered by solr-cell-\d.*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 819919 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/clustering/lib
 filtered by .*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/clustering/lib
   [junit4]   2> 819919 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
 filtered by solr-clustering-\d.*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 819919 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/langid/lib
 filtered by .*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/langid/lib
   [junit4]   2> 819920 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
 filtered by solr-langid-\d.*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 819920 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/ltr/lib
 filtered by .*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/ltr/lib
   [junit4]   2> 819920 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
 filtered by solr-ltr-\d.*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 819921 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/velocity/lib
 filtered by .*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../contrib/velocity/lib
   [junit4]   2> 819921 WARN  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Couldn't add files from 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
 filtered by solr-velocity-\d.*\.jar to classpath: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/../../../../dist
   [junit4]   2> 819934 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.SolrIndexConfig IndexWriter infoStream solr logging is 
enabled
   [junit4]   2> 819937 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 820004 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=example
   [junit4]   2> 820575 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.rest.schema.analysis.ManagedWordSetResource for path 
/schema/analysis/stopwords/english
   [junit4]   2> 820583 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.RestManager Registered ManagedResource impl 
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory$SynonymManager 
for path /schema/analysis/synonyms/english
   [junit4]   2> 820595 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.IndexSchema Loaded schema example/1.6 with uniqueid 
field id
   [junit4]   2> 820595 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedStopFilterFactory to existing 
ManagedResource /schema/analysis/stopwords/english
   [junit4]   2> 820595 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.RestManager Added observer of type 
org.apache.solr.rest.schema.analysis.ManagedSynonymFilterFactory to existing 
ManagedResource /schema/analysis/synonyms/english
   [junit4]   2> 820634 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using 
configuration from instancedir 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1,
 trusted=true
   [junit4]   2> 820634 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620
   [junit4]   2> 820634 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 820634 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/data/]
   [junit4]   2> 820681 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
init: current segments file is "segments"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@28277de8
   [junit4]   2> 820681 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
init: create=true
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@19eb2ea3 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e8ce68f)
   [junit4]   2> index=
   [junit4]   2> version=7.0.0
   [junit4]   2> 
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
   [junit4]   2> ramBufferSizeMB=100.0
   [junit4]   2> maxBufferedDocs=-1
   [junit4]   2> maxBufferedDeleteTerms=-1
   [junit4]   2> mergedSegmentWarmer=null
   [junit4]   2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
   [junit4]   2> commit=null
   [junit4]   2> openMode=CREATE
   [junit4]   2> 
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
   [junit4]   2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, 
maxMergeCount=-1, ioThrottle=true
   [junit4]   2> codec=Lucene70
   [junit4]   2> infoStream=org.apache.solr.update.LoggingInfoStream
   [junit4]   2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, 
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, 
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@fead1a0
   [junit4]   2> readerPooling=false
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@4fb468c8
   [junit4]   2> 
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
now flush at close
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]:   
start flush: applyAllDeletes=true
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]:   
index before flush 
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
startFullFlush
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
coreLoadExecutor-935-thread-1 finishFullFlush success=true
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
apply all deletes during flush
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-935-thread-1]: 
prune sis=segments:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-935-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-935-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-935-thread-1]: 
now merge
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-935-thread-1]:   
index: 
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreLoadExecutor-935-thread-1]:   
no more merges pending; now return
   [junit4]   2> 820682 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
waitForMerges
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
waitForMerges done
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: start
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: enter lock
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: now prepare
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
prepareCommit: flush
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]:   
index before flush 
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
startFullFlush
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
apply all deletes during flush
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-935-thread-1]: 
prune sis=segments:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
coreLoadExecutor-935-thread-1 finishFullFlush success=true
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
startCommit(): start
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
startCommit index= changeCount=2
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
startCommit: wrote pending segments file "pending_segments_1"
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
done all syncs: []
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: pendingCommit != null
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: done writing segments file "segments_1"
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
now checkpoint "" [0 segments ; isCommit = true]
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: took 0.5 msec
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
commit: done
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
rollback
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
all running merges have aborted
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
rollback: done finish merges
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
abort
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
done abort success=true
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
rollback: infos=
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 820683 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 820726 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
   [junit4]   2> 820995 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 820995 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= 
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 820998 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 
15000ms; 
   [junit4]   2> 820998 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 820999 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
init: current segments file is "segments_1"; 
deletionPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper@28277de8
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
init: load commit "segments_1"
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
delete []
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreLoadExecutor-935-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
init: create=false
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
   [junit4]   2> dir=MockDirectoryWrapper(RAMDirectory@19eb2ea3 
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@6e8ce68f)
   [junit4]   2> index=
   [junit4]   2> version=7.0.0
   [junit4]   2> 
analyzer=org.apache.solr.update.SolrIndexConfig$DelayedSchemaAnalyzer
   [junit4]   2> ramBufferSizeMB=100.0
   [junit4]   2> maxBufferedDocs=-1
   [junit4]   2> maxBufferedDeleteTerms=-1
   [junit4]   2> mergedSegmentWarmer=null
   [junit4]   2> delPolicy=org.apache.solr.core.IndexDeletionPolicyWrapper
   [junit4]   2> commit=null
   [junit4]   2> openMode=APPEND
   [junit4]   2> 
similarity=org.apache.solr.search.similarities.SchemaSimilarityFactory$SchemaSimilarity
   [junit4]   2> mergeScheduler=ConcurrentMergeScheduler: maxThreadCount=-1, 
maxMergeCount=-1, ioThrottle=true
   [junit4]   2> codec=Lucene70
   [junit4]   2> infoStream=org.apache.solr.update.LoggingInfoStream
   [junit4]   2> mergePolicy=[TieredMergePolicy: maxMergeAtOnce=10, 
maxMergeAtOnceExplicit=30, maxMergedSegmentMB=5120.0, floorSegmentMB=2.0, 
forceMergeDeletesPctAllowed=10.0, segmentsPerTier=10.0, 
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1
   [junit4]   2> 
indexerThreadPool=org.apache.lucene.index.DocumentsWriterPerThreadPool@1408874e
   [junit4]   2> readerPooling=false
   [junit4]   2> perThreadHardLimitMB=1945
   [junit4]   2> useCompoundFile=false
   [junit4]   2> commitOnClose=true
   [junit4]   2> indexSort=null
   [junit4]   2> writer=org.apache.solr.update.SolrIndexWriter@912a7d9
   [junit4]   2> 
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
MMapDirectory.UNMAP_SUPPORTED=true
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
flush at getReader
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
startFullFlush
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
apply all deletes during flush
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreLoadExecutor-935-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
incRefDeleter for NRT reader version=2 segments=
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
return reader version=2 reader=StandardDirectoryReader(segments_1:2:nrt)
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreLoadExecutor-935-thread-1]: 
coreLoadExecutor-935-thread-1 finishFullFlush success=true
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreLoadExecutor-935-thread-1]: 
getReader took 0 msec
   [junit4]   2> 821000 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@d072c45[collection1] 
main]
   [junit4]   2> 821001 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage File-based storage initialized to 
use dir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/conf
   [junit4]   2> 821001 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_rest_managed.json using 
file:dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/conf
   [junit4]   2> 821001 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {} for /rest/managed
   [junit4]   2> 821002 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_stopwords_english.json using 
file:dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/conf
   [junit4]   2> 821002 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs {ignoreCase=true} for 
/schema/analysis/stopwords/english
   [junit4]   2> 821002 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedWordSetResource Loaded 35 words for 
/schema/analysis/stopwords/english
   [junit4]   2> 821002 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 2 observers of 
/schema/analysis/stopwords/english
   [junit4]   2> 821003 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResourceStorage Loaded LinkedHashMap at path 
_schema_analysis_synonyms_english.json using 
file:dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/conf
   [junit4]   2> 821003 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Loaded initArgs 
{ignoreCase=true,format=solr} for /schema/analysis/synonyms/english
   [junit4]   2> 821007 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.s.a.ManagedSynonymFilterFactory Loaded 3 synonym 
mappings for /schema/analysis/synonyms/english
   [junit4]   2> 821023 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.r.ManagedResource Notified 2 observers of 
/schema/analysis/synonyms/english
   [junit4]   2> 821024 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
   [junit4]   2> 821052 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.DirectSolrSpellChecker init: 
{name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
   [junit4]   2> 821052 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.h.c.SuggestComponent Initializing SuggestComponent
   [junit4]   2> 821071 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.s.SolrSuggester init: 
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
   [junit4]   2> 821186 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.s.s.SolrSuggester Dictionary loaded with params: 
{name=mySuggester,lookupImpl=FuzzyLookupFactory,dictionaryImpl=DocumentDictionaryFactory,field=cat,weightField=price,suggestAnalyzerFieldType=string,buildOnStartup=false}
   [junit4]   2> 821194 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.h.c.QueryElevationComponent Loading QueryElevation from: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001/tempDir-001/collection1/conf/elevate.xml
   [junit4]   2> 821227 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 821227 INFO  (coreLoadExecutor-935-thread-1) [    
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent 
updates, using new clock 1566474315895930880
   [junit4]   2> 821227 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener sending requests to 
Searcher@d072c45[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 821236 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.S.Request [collection1]  webapp=null path=null 
params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher}
 hits=0 status=0 QTime=6
   [junit4]   2> 821236 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.QuerySenderListener QuerySenderListener done.
   [junit4]   2> 821236 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
   [junit4]   2> 821236 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: wordbreak
   [junit4]   2> 821238 INFO  
(searcherExecutor-936-thread-1-processing-x:collection1) [    x:collection1] 
o.a.s.c.SolrCore [collection1] Registered new searcher 
Searcher@d072c45[collection1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 821413 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrJettyTestBase Jetty Assigned Port#52652
   [junit4]   2> 821419 INFO  
(TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSetupJvmMetrics
   [junit4]   2> 821419 INFO  
(TEST-JvmMetricsTest.testSetupJvmMetrics-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testSetupJvmMetrics
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=JvmMetricsTest 
-Dtests.method=testSetupJvmMetrics -Dtests.seed=8F621F0DA00D04EF 
-Dtests.slow=true -Dtests.locale=ar-OM -Dtests.timezone=Pacific/Honolulu 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.01s J0 | JvmMetricsTest.testSetupJvmMetrics <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8F621F0DA00D04EF:33D6C9B7B1BDCB8D]:0)
   [junit4]    >        at 
org.apache.solr.metrics.JvmMetricsTest.testSetupJvmMetrics(JvmMetricsTest.java:142)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 821428 INFO  
(TEST-JvmMetricsTest.testHiddenSysProps-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testHiddenSysProps
   [junit4]   2> 821435 INFO  
(TEST-JvmMetricsTest.testHiddenSysProps-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 821442 INFO  
(TEST-JvmMetricsTest.testHiddenSysProps-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.c.SolrXmlConfig MBean server found: 
com.sun.jmx.mbeanserver.JmxMBeanServer@92b2620, but no JMX reporters were 
configured - adding default JMX reporter.
   [junit4]   2> 821443 INFO  
(TEST-JvmMetricsTest.testHiddenSysProps-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testHiddenSysProps
   [junit4]   2> 821448 INFO  
(TEST-JvmMetricsTest.testAltBufferPoolMetricSet-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAltBufferPoolMetricSet
   [junit4]   2> 821453 INFO  
(TEST-JvmMetricsTest.testAltBufferPoolMetricSet-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAltBufferPoolMetricSet
   [junit4]   2> 821459 INFO  
(TEST-JvmMetricsTest.testSystemProperties-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSystemProperties
   [junit4]   2> 821460 INFO  
(TEST-JvmMetricsTest.testSystemProperties-seed#[8F621F0DA00D04EF]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testSystemProperties
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=JvmMetricsTest 
-Dtests.method=testSystemProperties -Dtests.seed=8F621F0DA00D04EF 
-Dtests.slow=true -Dtests.locale=ar-OM -Dtests.timezone=Pacific/Honolulu 
-Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 0.01s J0 | JvmMetricsTest.testSystemProperties <<<
   [junit4]    > Throwable #1: java.lang.AssertionError
   [junit4]    >        at 
__randomizedtesting.SeedInfo.seed([8F621F0DA00D04EF:E2CC8968D24B0C25]:0)
   [junit4]    >        at 
org.apache.solr.metrics.JvmMetricsTest.testSystemProperties(JvmMetricsTest.java:107)
   [junit4]    >        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 821468 INFO  
(TEST-JvmMetricsTest.testOperatingSystemMetricSet-seed#[8F621F0DA00D04EF]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testOperatingSystemMetricSet
   [junit4]   2> 821494 INFO  
(TEST-JvmMetricsTest.testOperatingSystemMetricSet-seed#[8F621F0DA00D04EF]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testOperatingSystemMetricSet
   [junit4]   2> 821496 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.e.j.s.AbstractConnector Stopped 
ServerConnector@19a3fffe{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
   [junit4]   2> 821496 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.CoreContainer Shutting down CoreContainer instance=1847089276
   [junit4]   2> 821496 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, 
tag=null
   [junit4]   2> 821498 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, 
tag=null
   [junit4]   2> 821498 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, 
tag=null
   [junit4]   2> 821498 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 821499 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.c.SolrCore [collection1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@694f41c8
   [junit4]   2> 821500 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
now flush at close
   [junit4]   2> 821500 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]:  
 start flush: applyAllDeletes=true
   [junit4]   2> 821500 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]:  
 index before flush 
   [junit4]   2> 821500 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
startFullFlush
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
coreCloseExecutor-941-thread-1 finishFullFlush success=true
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
apply all deletes during flush
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-941-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-941-thread-1]: 
initDynamicDefaults spins=false maxThreadCount=1 maxMergeCount=6
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-941-thread-1]: 
updateMergeThreads ioThrottle=true targetMBPerSec=10240.0 MB/sec
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-941-thread-1]: 
now merge
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-941-thread-1]:  
 index: 
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [MS][coreCloseExecutor-941-thread-1]:  
 no more merges pending; now return
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
waitForMerges
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
waitForMerges done
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: start
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: enter lock
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: now prepare
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
prepareCommit: flush
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]:  
 index before flush 
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
startFullFlush
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
apply all deletes during flush
   [junit4]   2> 821501 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
now apply all deletes for all segments maxDoc=0
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [BD][coreCloseExecutor-941-thread-1]: 
prune sis=segments_1:  minGen=9223372036854775807 packetCount=0
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
coreCloseExecutor-941-thread-1 finishFullFlush success=true
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
startCommit(): start
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]:  
 skip startCommit(): no changes pending
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-941-thread-1]: 
delete []
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: pendingCommit == null; skip
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: took 0.3 msec
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
commit: done
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
rollback
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
all running merges have aborted
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
rollback: done finish merges
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
abort
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [DW][coreCloseExecutor-941-thread-1]: 
done abort success=true
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IW][coreCloseExecutor-941-thread-1]: 
rollback: infos=
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-941-thread-1]: 
now checkpoint "" [0 segments ; isCommit = false]
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-941-thread-1]: 
delete []
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-941-thread-1]: 
0 msec to checkpoint
   [junit4]   2> 821502 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.u.LoggingInfoStream [IFD][coreCloseExecutor-941-thread-1]: 
delete []
   [junit4]   2> 821503 INFO  (coreCloseExecutor-941-thread-1) [    
x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1, tag=1766801864
   [junit4]   2> 821510 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@25b87ef7{/solr,null,UNAVAILABLE}
   [junit4]   2> 821512 INFO  
(SUITE-JvmMetricsTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J0/temp/solr.metrics.JvmMetricsTest_8F621F0DA00D04EF-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, 
docValues:{}, maxPointsInLeafNode=396, maxMBSortInHeap=6.5631979695768345, 
sim=RandomSimilarity(queryNorm=true): {}, locale=ar-OM, 
timezone=Pacific/Honolulu
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_131 
(64-bit)/cpus=3,threads=1,free=326764512,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[TestInPlaceUpdatesStandalone, TestPostingsSolrHighlighter, HardAutoCommitTest, 
TestNumericTerms64, TestFaceting, TestEmbeddedSolrServerConstructors, 
TestOverriddenPrefixQueryForCustomFieldType, CopyFieldTest, TestFieldCacheSort, 
XsltUpdateRequestHandlerTest, TestHdfsCloudBackupRestore, FileUtilsTest, 
NodeMutatorTest, LeaderElectionTest, CheckHdfsIndexTest, SolrPluginUtilsTest, 
VersionInfoTest, IgnoreCommitOptimizeUpdateProcessorFactoryTest, 
TestCoreContainer, CursorPagingTest, TestRemoteStreaming, PeerSyncTest, 
DistributedFacetPivotLongTailTest, TestSort, BasicDistributedZkTest, 
TestStressLucene, TestBinaryResponseWriter, JvmMetricsTest]
   [junit4] Completed [72/709 (1!)] on J0 in 2.84s, 5 tests, 2 failures <<< 
FAILURES!

[...truncated 627 lines...]
   [junit4] Suite: org.apache.solr.metrics.reporters.solr.SolrCloudReportersTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001/init-core-data-001
   [junit4]   2> 1937835 WARN  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
   [junit4]   2> 1937835 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields
   [junit4]   2> 1937840 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 1937840 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 0 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001/tempDir-001
   [junit4]   2> 1937840 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1937841 INFO  (Thread-2292) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1937841 INFO  (Thread-2292) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1937846 ERROR (Thread-2292) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1937949 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:56286
   [junit4]   2> 1938995 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.SolrTestCaseJ4 ###Starting testExplicitConfiguration
   [junit4]   2> 1938995 ERROR 
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so 
ZooKeeper server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1938995 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:56286 56286
   [junit4]   2> 1939018 INFO  (Thread-2292) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:56286 56286
   [junit4]   2> 1948768 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001/tempDir-002
   [junit4]   2> 1948768 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 1948769 INFO  (Thread-2293) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 1948769 INFO  (Thread-2293) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 1948772 ERROR (Thread-2293) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1948877 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.ZkTestServer start zk server on port:56289
   [junit4]   2> 1948902 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1948902 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 1948904 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@13917fb4{/solr,null,AVAILABLE}
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@406236e7{HTTP/1.1,[http/1.1]}{127.0.0.1:56291}
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.e.j.s.Server Started @1954498ms
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=56291}
   [junit4]   2> 1948905 ERROR (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@501f5c75{/solr,null,AVAILABLE}
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@394a00ec{HTTP/1.1,[http/1.1]}{127.0.0.1:56292}
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.e.j.s.Server Started @1954498ms
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=56292}
   [junit4]   2> 1948905 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 1948905 ERROR (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-05-04T14:17:29.937Z
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.0.0
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 1948906 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-05-04T14:17:29.937Z
   [junit4]   2> 1948910 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1948910 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 1948928 INFO  (jetty-launcher-2650-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56289/solr
   [junit4]   2> 1948928 INFO  (jetty-launcher-2650-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56289/solr
   [junit4]   2> 1948976 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1948976 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 1948977 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:56292_solr
   [junit4]   2> 1948979 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:56291_solr
   [junit4]   2> 1948980 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.Overseer Overseer 
(id=97904718630223878-127.0.0.1:56292_solr-n_0000000000) starting
   [junit4]   2> 1948982 INFO  
(zkCallback-2662-thread-1-processing-n:127.0.0.1:56292_solr) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1948982 INFO  
(zkCallback-2661-thread-1-processing-n:127.0.0.1:56291_solr) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 1949002 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:56292_solr
   [junit4]   2> 1949005 INFO  
(zkCallback-2661-thread-1-processing-n:127.0.0.1:56291_solr) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1949005 INFO  
(zkCallback-2662-thread-1-processing-n:127.0.0.1:56292_solr) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 1950175 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.node
   [junit4]   2> 1950175 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.jvm
   [junit4]   2> 1950175 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.jetty
   [junit4]   2> 1950176 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.node
   [junit4]   2> 1950176 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.jvm
   [junit4]   2> 1950176 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.m.r.SolrJmxReporter Reporter disabled for 
registry solr.jetty
   [junit4]   2> 1950440 INFO  (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001/tempDir-002/node1
   [junit4]   2> 1950440 INFO  (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001/tempDir-002/node2
   [junit4]   2> 1950441 ERROR (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.s.SolrDispatchFilter Could not start Solr. 
Check solr/home property and the logs
   [junit4]   2> 1950441 ERROR (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.s.SolrDispatchFilter Could not start Solr. 
Check solr/home property and the logs
   [junit4]   2> 1950442 ERROR (jetty-launcher-2650-thread-2) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.SolrCore 
null:java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.setupJvmMetrics(SolrDispatchFilter.java:194)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:175)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:137)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1565)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1599)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1285)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1130)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:306)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:394)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:367)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:382)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:245)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   2> 1950442 ERROR (jetty-launcher-2650-thread-1) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.SolrCore 
null:java.lang.NullPointerException
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.setupJvmMetrics(SolrDispatchFilter.java:194)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.init(SolrDispatchFilter.java:175)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.FilterHolder.initialize(FilterHolder.java:137)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.initialize(ServletHandler.java:873)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.updateMappings(ServletHandler.java:1565)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.setFilterMappings(ServletHandler.java:1599)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterMapping(ServletHandler.java:1285)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.addFilterWithMapping(ServletHandler.java:1130)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletContextHandler.addFilter(ServletContextHandler.java:448)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$1.lifeCycleStarted(JettySolrRunner.java:306)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.setStarted(AbstractLifeCycle.java:179)
   [junit4]   2>        at 
org.eclipse.jetty.util.component.AbstractLifeCycle.start(AbstractLifeCycle.java:69)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:394)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner.start(JettySolrRunner.java:367)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.startJettySolrRunner(MiniSolrCloudCluster.java:382)
   [junit4]   2>        at 
org.apache.solr.cloud.MiniSolrCloudCluster.lambda$new$0(MiniSolrCloudCluster.java:245)
   [junit4]   2>        at 
java.util.concurrent.FutureTask.run(FutureTask.java:266)
   [junit4]   2>        at 
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
   [junit4]   2>        at 
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 
   [junit4]   1> ZK: 127.0.0.1:56289/solr
   [junit4]   2> 1950484 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 1950486 INFO  
(TEST-SolrCloudReportersTest.testExplicitConfiguration-seed#[8F621F0DA00D04EF]) 
[    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56289/solr 
ready
   [junit4]   2> 1950491 INFO  (qtp1623885333-14309) [n:127.0.0.1:56292_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=2&collection.configName=test&maxShardsPerNode=4&name=test_collection&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 1950496 INFO  
(OverseerThreadFactory-5428-thread-1-processing-n:127.0.0.1:56292_solr) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
test_collection
   [junit4]   2> 1950610 INFO  (qtp1428263752-14301) [n:127.0.0.1:56291_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=test&newCollection=true&name=test_collection_shard1_replica2&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2
   [junit4]   2> 1950610 INFO  (qtp1428263752-14300) [n:127.0.0.1:56291_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=test&newCollection=true&name=test_collection_shard2_replica2&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2
   [junit4]   2> 1950611 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=test&newCollection=true&name=test_collection_shard2_replica1&action=CREATE&numShards=2&collection=test_collection&shard=shard2&wt=javabin&version=2
   [junit4]   2> 1950618 INFO  (qtp1428263752-14301) [n:127.0.0.1:56291_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1950610 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr    
] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=test&newCollection=true&name=test_collection_shard1_replica1&action=CREATE&numShards=2&collection=test_collection&shard=shard1&wt=javabin&version=2
   [junit4]   2> 1950618 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr    
] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 
2147483647 transient cores
   [junit4]   2> 1950740 INFO  
(zkCallback-2661-thread-1-processing-n:127.0.0.1:56291_solr) 
[n:127.0.0.1:56291_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/test_collection/state.json] for collection [test_collection] 
has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1950740 INFO  
(zkCallback-2662-thread-1-processing-n:127.0.0.1:56292_solr) 
[n:127.0.0.1:56292_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/test_collection/state.json] for collection [test_collection] 
has occurred - updating... (live nodes size: [2])
   [junit4]   2> 1951664 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1951664 INFO  (qtp1428263752-14300) [n:127.0.0.1:56291_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1951707 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1951719 INFO  (qtp1428263752-14301) [n:127.0.0.1:56291_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
   [junit4]   2> 1951721 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.s.IndexSchema [test_collection_shard1_replica1] Schema name=minimal
   [junit4]   2> 1951727 WARN  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 1951728 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
   [junit4]   2> 1951728 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard1_replica1' using 
configuration from collection test_collection, trusted=true
   [junit4]   2> 1951728 INFO  (qtp1623885333-14310) [n:127.0.0.1:56292_solr 
c:test_collection s:shard1  x:test_collection_shard1_replica1] 
o.a.s.m.r.SolrJmxReporter Reporter disabled for registry 
solr.core.test_collection.shard1.replica1
   [junit4]   2> 1951731 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica1] 
o.a.s.s.IndexSchema [test_collection_shard2_replica1] Schema name=minimal
   [junit4]   2> 1951735 INFO  (qtp1428263752-14300) [n:127.0.0.1:56291_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica2] 
o.a.s.s.IndexSchema [test_collection_shard2_replica2] Schema name=minimal
   [junit4]   2> 1951736 WARN  (qtp1623885333-14313) [n:127.0.0.1:56292_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica1] 
o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 1951736 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica1] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
   [junit4]   2> 1951736 INFO  (qtp1623885333-14313) [n:127.0.0.1:56292_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica1] 
o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard2_replica1' using 
configuration from collection test_collection, trusted=true
   [junit4]   2> 1951737 WARN  (qtp1428263752-14300) [n:127.0.0.1:56291_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica2] 
o.a.s.s.IndexSchema no uniqueKey specified in schema.
   [junit4]   2> 1951737 INFO  (qtp1428263752-14300) [n:127.0.0.1:56291_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica2] 
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field null
   [junit4]   2> 1951737 INFO  (qtp1428263752-14300) [n:127.0.0.1:56291_solr 
c:test_collection s:shard2  x:test_collection_shard2_replica2] 
o.a.s.c.CoreContainer Creating SolrCore 'test_collection_shard2_replica2' using 
configuration from collection test_collection, trusted=true
   [juni

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

eCloseExecutor-5483-thread-1) [n:127.0.0.1:56335_solr c:test_collection 
s:shard1 r:core_node3 x:test_collection_shard1_replica2] o.a.s.c.SolrCore 
[test_collection_shard1_replica2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@5f010730
   [junit4]   2> 1978071 INFO  (coreCloseExecutor-5484-thread-2) 
[n:127.0.0.1:56336_solr c:test_collection s:shard1 r:core_node1 
x:test_collection_shard1_replica1] o.a.s.c.SolrCore 
[test_collection_shard1_replica1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@57b61d28
   [junit4]   2> 1978072 INFO  (coreCloseExecutor-5483-thread-2) 
[n:127.0.0.1:56335_solr c:test_collection s:shard2 r:core_node2 
x:test_collection_shard2_replica2] o.a.s.c.SolrCore 
[test_collection_shard2_replica2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@426cd258
   [junit4]   2> 1978074 INFO  (coreCloseExecutor-5483-thread-1) 
[n:127.0.0.1:56335_solr c:test_collection s:shard1 r:core_node3 
x:test_collection_shard1_replica2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.test_collection.shard1.replica2, tag=1593902896
   [junit4]   2> 1978075 INFO  (coreCloseExecutor-5484-thread-2) 
[n:127.0.0.1:56336_solr c:test_collection s:shard1 r:core_node1 
x:test_collection_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.test_collection.shard1.replica1, tag=1471552808
   [junit4]   2> 1978087 INFO  (coreCloseExecutor-5484-thread-2) 
[n:127.0.0.1:56336_solr c:test_collection s:shard1 r:core_node1 
x:test_collection_shard1_replica1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.test_collection.shard1.leader, 
tag=1471552808
   [junit4]   2> 1978088 INFO  (coreCloseExecutor-5484-thread-1) 
[n:127.0.0.1:56336_solr c:test_collection s:shard2 r:core_node4 
x:test_collection_shard2_replica1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.test_collection.shard2.replica1, tag=346686426
   [junit4]   2> 1978089 INFO  (coreCloseExecutor-5483-thread-1) 
[n:127.0.0.1:56335_solr c:test_collection s:shard1 r:core_node3 
x:test_collection_shard1_replica2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.test_collection.shard1.leader, 
tag=1593902896
   [junit4]   2> 1978089 INFO  (coreCloseExecutor-5483-thread-2) 
[n:127.0.0.1:56335_solr c:test_collection s:shard2 r:core_node2 
x:test_collection_shard2_replica2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.test_collection.shard2.replica2, tag=1114427992
   [junit4]   2> 1978100 INFO  (coreCloseExecutor-5484-thread-1) 
[n:127.0.0.1:56336_solr c:test_collection s:shard2 r:core_node4 
x:test_collection_shard2_replica1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.test_collection.shard2.leader, 
tag=346686426
   [junit4]   2> 1978100 INFO  (coreCloseExecutor-5483-thread-2) 
[n:127.0.0.1:56335_solr c:test_collection s:shard2 r:core_node2 
x:test_collection_shard2_replica2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.test_collection.shard2.leader, 
tag=1114427992
   [junit4]   2> 1978102 INFO  (jetty-closer-2671-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=97904720272752646-127.0.0.1:56336_solr-n_0000000000) closing
   [junit4]   2> 1978102 INFO  
(OverseerStateUpdate-97904720272752646-127.0.0.1:56336_solr-n_0000000000) 
[n:127.0.0.1:56336_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:56336_solr
   [junit4]   2> 1978106 WARN  
(zkCallback-2681-thread-1-processing-n:127.0.0.1:56335_solr) 
[n:127.0.0.1:56335_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1978107 INFO  (jetty-closer-2671-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@45ff9a46{/solr,null,UNAVAILABLE}
   [junit4]   2> 1978107 INFO  
(zkCallback-2682-thread-1-processing-n:127.0.0.1:56336_solr) 
[n:127.0.0.1:56336_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (1)
   [junit4]   2> 1978108 WARN  
(zkCallback-2682-thread-1-processing-n:127.0.0.1:56336_solr) 
[n:127.0.0.1:56336_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 1978109 INFO  (jetty-closer-2671-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@423bdb45{/solr,null,UNAVAILABLE}
   [junit4]   2> 1978110 ERROR 
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 1978112 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:56333 56333
   [junit4]   2> 1978132 INFO  (Thread-2314) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:56333 56333
   [junit4]   2> 1986559 WARN  (Thread-2314) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/aliases.json
   [junit4]   2>        3       /solr/clusterprops.json
   [junit4]   2>        2       /solr/configs/test
   [junit4]   2>        2       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/clusterstate.json
   [junit4]   2>        3       /solr/collections/test_collection/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        3       /solr/live_nodes
   [junit4]   2>        3       /solr/collections
   [junit4]   2> 
   [junit4]   2> 1986560 INFO  
(SUITE-SolrCloudReportersTest-seed#[8F621F0DA00D04EF]-worker) [    ] 
o.a.s.SolrTestCaseJ4 ###deleteCore
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.metrics.reporters.solr.SolrCloudReportersTest_8F621F0DA00D04EF-001
   [junit4]   2> NOTE: test params are: 
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
 chunkSize=1, maxDocsPerChunk=5, blockSize=362), 
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY, 
chunkSize=1, blockSize=362)), sim=RandomSimilarity(queryNorm=false): {}, 
locale=it-IT, timezone=Europe/Malta
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_131 
(64-bit)/cpus=3,threads=1,free=355658888,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: 
[DocExpirationUpdateProcessorFactoryTest, PeerSyncReplicationTest, 
TestPayloadCheckQParserPlugin, SimpleCollectionCreateDeleteTest, 
TestCryptoKeys, TestExpandComponent, ResponseLogComponentTest, 
UUIDUpdateProcessorFallbackTest, TestSlowCompositeReaderWrapper, 
HighlighterMaxOffsetTest, RequestHandlersTest, OpenCloseCoreStressTest, 
TestAddFieldRealTimeGet, DirectoryFactoryTest, CdcrReplicationHandlerTest, 
SystemInfoHandlerTest, TestLegacyNumericRangeQueryBuilder, TestDocumentBuilder, 
StatsReloadRaceTest, TestHashQParserPlugin, MissingSegmentRecoveryTest, 
TestDistributedMissingSort, TestIndexingPerformance, SliceStateTest, 
DirectUpdateHandlerOptimizeTest, ForceLeaderTest, TestSmileRequest, 
TestEmbeddedSolrServerSchemaAPI, ShowFileRequestHandlerTest, 
CleanupOldIndexTest, ZkSolrClientTest, LeaderFailureAfterFreshStartTest, 
TestReload, TestRandomFaceting, TestCollectionAPIs, EchoParamsTest, 
CollectionsAPIDistributedZkTest, SolrCmdDistributorTest, 
TestAnalyzedSuggestions, TestPathTrie, AliasIntegrationTest, 
HdfsDirectoryFactoryTest, OnlyLeaderIndexesTest, DistribCursorPagingTest, 
ClassificationUpdateProcessorTest, JsonValidatorTest, BadComponentTest, 
TestSha256AuthenticationProvider, CreateCollectionCleanupTest, 
TestSchemalessBufferedUpdates, TestSearcherReuse, 
TestLeaderElectionWithEmptyReplica, TestStressCloudBlindAtomicUpdates, 
ConfigSetsAPITest, HLLUtilTest, DeleteNodeTest, TestHalfAndHalfDocValues, 
AsyncCallRequestStatusResponseTest, TestRecoveryHdfs, SolrInfoBeanTest, 
TestInitParams, HdfsUnloadDistributedZkTest, TestBlobHandler, 
SharedFSAutoReplicaFailoverTest, TestCloudSchemaless, TestCustomSort, 
SubstringBytesRefFilterTest, TestRandomRequestDistribution, StatsComponentTest, 
LeaderElectionContextKeyTest, TestTestInjection, SolrCloudExampleTest, 
NoCacheHeaderTest, RemoteQueryErrorTest, CoreMergeIndexesAdminHandlerTest, 
TestDistribIDF, LargeFieldTest, BlockJoinFacetRandomTest, AnalyticsQueryTest, 
TestCrossCoreJoin, LukeRequestHandlerTest, ClusterStateTest, 
TestQueryWrapperFilter, FullSolrCloudDistribCmdsTest, TestCoreDiscovery, 
BigEndianAscendingWordDeserializerTest, TestCustomStream, TestDocSet, 
TestNumericTerms32, SmileWriterTest, ConjunctionSolrSpellCheckerTest, 
ExternalFileFieldSortTest, TestNonDefinedSimilarityFactory, 
DistributedExpandComponentTest, TestRequestStatusCollectionAPI, TestConfigSets, 
SpatialHeatmapFacetsTest, TestFuzzyAnalyzedSuggestions, FacetPivotSmallTest, 
BasicAuthIntegrationTest, TestAuthenticationFramework, MinimalSchemaTest, 
LeaderInitiatedRecoveryOnShardRestartTest, UUIDFieldTest, 
ClassificationUpdateProcessorFactoryTest, SuggestComponentTest, 
URLClassifyProcessorTest, SecurityConfHandlerTest, CollectionReloadTest, 
SpellCheckCollatorTest, TestZkChroot, CoreAdminCreateDiscoverTest, 
SolrCoreMetricManagerTest, TestSolrIndexConfig, TestConfigSetsAPIExclusivity, 
CollectionsAPISolrJTest, TestRecovery, TestLuceneMatchVersion, 
TestDynamicFieldCollectionResource, TestLMJelinekMercerSimilarityFactory, 
ConnectionReuseTest, AutoCommitTest, TestStressLiveNodes, UpdateParamsTest, 
DistanceFunctionTest, DistributedFacetPivotWhiteBoxTest, TimeZoneUtilsTest, 
TestSolrCoreSnapshots, DistributedFacetPivotLargeTest, TestTrie, 
TestReqParamsAPI, ShardRoutingCustomTest, SolrCloudReportersTest]
   [junit4] Completed [267/709 (2!)] on J1 in 48.74s, 2 tests, 1 failure <<< 
FAILURES!

[...truncated 44861 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to