[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk-12.0.1) - Build # 5306 - Unstable!

classic Classic list List threaded Threaded
2 messages Options
Reply | Threaded
Open this post in threaded view
|

[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk-12.0.1) - Build # 5306 - Unstable!

Policeman Jenkins Server-2
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5306/
Java: 64bit/jdk-12.0.1 -XX:+UseCompressedOops -XX:+UseG1GC

2 tests failed.
FAILED:  org.apache.solr.handler.TestContainerReqHandler.testPackageAPI

Error Message:
attempt: 9 Mismatch for value : '[requestHandler]' in response {   "responseHeader":{     "status":0,     "QTime":0},   "metadata":{"version":3},   "runtimeLib":[{       "name":"global",       "url":"http://localhost:52811/jar3.jar",       "60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922":"60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922",       "znodeVersion":3}],   "requestHandler":[{       "name":"bar",       "znodeVersion":3,       "class":"org.apache.solr.core.RuntimeLibReqHandler",       "package":"global"}]}

Stack Trace:
java.lang.AssertionError: attempt: 9 Mismatch for value : '[requestHandler]' in response {
  "responseHeader":{
    "status":0,
    "QTime":0},
  "metadata":{"version":3},
  "runtimeLib":[{
      "name":"global",
      "url":"http://localhost:52811/jar3.jar",
      "60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922":"60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922",
      "znodeVersion":3}],
  "requestHandler":[{
      "name":"bar",
      "znodeVersion":3,
      "class":"org.apache.solr.core.RuntimeLibReqHandler",
      "package":"global"}]}
        at __randomizedtesting.SeedInfo.seed([8E54BF8BC06AF872:FC5BAAC56C31A262]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.apache.solr.handler.TestContainerReqHandler.assertResponseValues(TestContainerReqHandler.java:117)
        at org.apache.solr.handler.TestContainerReqHandler.testPackageAPI(TestContainerReqHandler.java:232)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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 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.base/java.lang.Thread.run(Thread.java:835)


FAILED:  org.apache.solr.handler.TestContainerReqHandler.testPackageAPI

Error Message:
attempt: 9 Mismatch for value : '[requestHandler]' in response {   "responseHeader":{     "status":0,     "QTime":0},   "metadata":{"version":3},   "runtimeLib":[{       "name":"global",       "url":"http://localhost:58268/jar3.jar",       "60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922":"60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922",       "znodeVersion":3}],   "requestHandler":[{       "name":"bar",       "znodeVersion":3,       "class":"org.apache.solr.core.RuntimeLibReqHandler",       "package":"global"}]}

Stack Trace:
java.lang.AssertionError: attempt: 9 Mismatch for value : '[requestHandler]' in response {
  "responseHeader":{
    "status":0,
    "QTime":0},
  "metadata":{"version":3},
  "runtimeLib":[{
      "name":"global",
      "url":"http://localhost:58268/jar3.jar",
      "60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922":"60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922",
      "znodeVersion":3}],
  "requestHandler":[{
      "name":"bar",
      "znodeVersion":3,
      "class":"org.apache.solr.core.RuntimeLibReqHandler",
      "package":"global"}]}
        at __randomizedtesting.SeedInfo.seed([8E54BF8BC06AF872:FC5BAAC56C31A262]:0)
        at org.junit.Assert.fail(Assert.java:88)
        at org.apache.solr.handler.TestContainerReqHandler.assertResponseValues(TestContainerReqHandler.java:117)
        at org.apache.solr.handler.TestContainerReqHandler.testPackageAPI(TestContainerReqHandler.java:232)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:567)
        at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
        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:947)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
        at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
        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 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.base/java.lang.Thread.run(Thread.java:835)




Build Log:
[...truncated 14833 lines...]
   [junit4] Suite: org.apache.solr.handler.TestContainerReqHandler
   [junit4]   2> 3946101 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 3946103 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/data-dir-265-001
   [junit4]   2> 3946103 WARN  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=22 numCloses=22
   [junit4]   2> 3946103 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 3946105 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="None") w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 3946108 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.SolrTestCaseJ4 ###Starting testPluginFrompackage
   [junit4]   2> 3946118 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 3946126 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.e.j.s.AbstractConnector Started ServerConnector@3878880{HTTP/1.1,[http/1.1]}{0.0.0.0:57997}
   [junit4]   2> 3946126 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.e.j.s.Server Started @3946173ms
   [junit4]   2> 3946127 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001
   [junit4]   2> 3946128 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 3946128 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 3946128 INFO  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Starting server
   [junit4]   2> 3946232 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer start zk server on port:57998
   [junit4]   2> 3946232 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:57998
   [junit4]   2> 3946232 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:57998
   [junit4]   2> 3946232 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 57998
   [junit4]   2> 3946235 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946246 INFO  (zkConnectionManagerCallback-25137-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946247 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946251 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946254 INFO  (zkConnectionManagerCallback-25139-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946254 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946255 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946258 INFO  (zkConnectionManagerCallback-25141-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946258 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946369 WARN  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 3946369 WARN  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3946369 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 3946370 WARN  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3946370 WARN  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
   [junit4]   2> 3946370 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 12.0.1+12
   [junit4]   2> 3946372 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3946372 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3946372 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 3946373 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@30182515{/solr,null,AVAILABLE}
   [junit4]   2> 3946373 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.AbstractConnector Started ServerConnector@11569ff6{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:58003}
   [junit4]   2> 3946373 INFO  (jetty-launcher-25142-thread-2) [     ] o.e.j.s.Server Started @3946420ms
   [junit4]   2> 3946373 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58003}
   [junit4]   2> 3946373 ERROR (jetty-launcher-25142-thread-2) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 3946373 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3946375 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 3946375 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3946375 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3946375 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-08-22T20:47:49.701759Z
   [junit4]   2> 3946379 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3946379 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3946379 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.session node0 Scavenging every 600000ms
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@34792d8e{/solr,null,AVAILABLE}
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.AbstractConnector Started ServerConnector@6cbc88fa{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:58004}
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-4) [     ] o.e.j.s.Server Started @3946427ms
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4cedca1f{/solr,null,AVAILABLE}
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.AbstractConnector Started ServerConnector@64560947{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:58005}
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-1) [     ] o.e.j.s.Server Started @3946428ms
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58005}
   [junit4]   2> 3946381 ERROR (jetty-launcher-25142-thread-1) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946381 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 3946380 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58004}
   [junit4]   2> 3946383 ERROR (jetty-launcher-25142-thread-4) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 3946383 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3946383 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 3946383 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3946383 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3946383 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-08-22T20:47:49.709492Z
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.session node0 Scavenging every 660000ms
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@20cefbf1{/solr,null,AVAILABLE}
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3946384 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-08-22T20:47:49.710796Z
   [junit4]   2> 3946385 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.AbstractConnector Started ServerConnector@2969eae2{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:58006}
   [junit4]   2> 3946385 INFO  (jetty-launcher-25142-thread-3) [     ] o.e.j.s.Server Started @3946432ms
   [junit4]   2> 3946385 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58006}
   [junit4]   2> 3946385 ERROR (jetty-launcher-25142-thread-3) [     ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
   [junit4]   2> 3946385 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 3946385 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 9.0.0
   [junit4]   2> 3946386 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 3946386 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 3946386 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 2019-08-22T20:47:49.712053Z
   [junit4]   2> 3946387 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946387 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946388 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946388 INFO  (zkConnectionManagerCallback-25144-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946388 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946390 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3946395 INFO  (zkConnectionManagerCallback-25148-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946395 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946396 INFO  (zkConnectionManagerCallback-25150-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946396 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946396 INFO  (zkConnectionManagerCallback-25146-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946397 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946398 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3946398 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3946398 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 3946725 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3946726 WARN  (jetty-launcher-25142-thread-3) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@43dd27c1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946726 WARN  (jetty-launcher-25142-thread-3) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@43dd27c1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946729 WARN  (jetty-launcher-25142-thread-3) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@9495657[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946729 WARN  (jetty-launcher-25142-thread-3) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@9495657[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946730 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57998/solr
   [junit4]   2> 3946741 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946742 INFO  (zkConnectionManagerCallback-25158-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946742 INFO  (jetty-launcher-25142-thread-3) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946825 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3946827 WARN  (jetty-launcher-25142-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6eb479b1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946827 WARN  (jetty-launcher-25142-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6eb479b1[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946829 WARN  (jetty-launcher-25142-thread-1) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6141838[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946829 WARN  (jetty-launcher-25142-thread-1) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6141838[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3946830 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57998/solr
   [junit4]   2> 3946831 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946833 INFO  (zkConnectionManagerCallback-25165-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946833 INFO  (jetty-launcher-25142-thread-1) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946953 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946955 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3946956 INFO  (zkConnectionManagerCallback-25168-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946956 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3946957 INFO  (zkConnectionManagerCallback-25170-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3946957 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947132 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947133 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947134 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> []
   [junit4]   2> 3947135 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947142 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58005_solr
   [junit4]   2> 3947143 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.Overseer Overseer (id=72229591009394698-127.0.0.1:58005_solr-n_0000000000) starting
   [junit4]   2> 3947154 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947156 INFO  (zkConnectionManagerCallback-25179-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947156 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947156 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947157 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947158 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> []
   [junit4]   2> 3947159 DEBUG (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947161 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57998/solr ready
   [junit4]   2> 3947162 INFO  (OverseerStateUpdate-72229591009394698-127.0.0.1:58005_solr-n_0000000000) [n:127.0.0.1:58005_solr     ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:58005_solr
   [junit4]   2> 3947165 DEBUG (OverseerStateUpdate-72229591009394698-127.0.0.1:58005_solr-n_0000000000) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> []
   [junit4]   2> 3947165 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58005_solr
   [junit4]   2> 3947166 DEBUG (OverseerStateUpdate-72229591009394698-127.0.0.1:58005_solr-n_0000000000) [n:127.0.0.1:58005_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947169 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0])
   [junit4]   2> 3947169 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0])
   [junit4]   2> 3947169 INFO  (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3947169 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58005_solr]
   [junit4]   2> 3947171 INFO  (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3947171 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58005_solr]
   [junit4]   2> 3947172 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947173 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947174 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 3947174 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58005_solr]
   [junit4]   2> 3947174 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.c.PackageManager clusterprops.json changed , version -1
   [junit4]   2> 3947175 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947181 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:58006_solr as DOWN
   [junit4]   2> 3947183 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 3947183 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58006_solr
   [junit4]   2> 3947184 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 3947184 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 3947185 INFO  (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3947185 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr] -> [127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947185 INFO  (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3947185 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr] -> [127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947186 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1])
   [junit4]   2> 3947186 INFO  (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
   [junit4]   2> 3947187 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr] -> [127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947188 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947190 INFO  (zkConnectionManagerCallback-25184-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947190 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947191 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947192 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947193 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3947193 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947194 DEBUG (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947195 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57998/solr ready
   [junit4]   2> 3947195 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.c.PackageManager clusterprops.json changed , version -1
   [junit4]   2> 3947221 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 3947244 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 3947263 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58005.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947271 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58006.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947278 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58005.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947278 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58005.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947280 INFO  (jetty-launcher-25142-thread-1) [n:127.0.0.1:58005_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.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node1/.
   [junit4]   2> 3947295 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58006.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947295 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58006.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947297 INFO  (jetty-launcher-25142-thread-3) [n:127.0.0.1:58006_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.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node3/.
   [junit4]   2> 3947350 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3947351 WARN  (jetty-launcher-25142-thread-4) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@54140f82[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947351 WARN  (jetty-launcher-25142-thread-4) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@54140f82[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947354 WARN  (jetty-launcher-25142-thread-4) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2d894080[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947354 WARN  (jetty-launcher-25142-thread-4) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2d894080[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947355 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57998/solr
   [junit4]   2> 3947356 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947358 INFO  (zkConnectionManagerCallback-25192-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947358 INFO  (jetty-launcher-25142-thread-4) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947375 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
   [junit4]   2> 3947375 WARN  (jetty-launcher-25142-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@ad37d43[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947375 WARN  (jetty-launcher-25142-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@ad37d43[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947378 WARN  (jetty-launcher-25142-thread-2) [     ] o.e.j.u.s.S.config Trusting all certificates configured for Client@7a8e315e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947378 WARN  (jetty-launcher-25142-thread-2) [     ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@7a8e315e[provider=null,keyStore=null,trustStore=null]
   [junit4]   2> 3947379 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57998/solr
   [junit4]   2> 3947380 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947382 INFO  (zkConnectionManagerCallback-25198-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947382 INFO  (jetty-launcher-25142-thread-2) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947470 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947472 INFO  (zkConnectionManagerCallback-25200-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947472 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947481 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947482 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947484 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 3947484 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947485 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947492 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:58004_solr as DOWN
   [junit4]   2> 3947494 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 3947494 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58004_solr
   [junit4]   2> 3947495 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2])
   [junit4]   2> 3947495 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2])
   [junit4]   2> 3947496 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2])
   [junit4]   2> 3947496 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2])
   [junit4]   2> 3947496 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [2])
   [junit4]   2> 3947497 INFO  (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 3947497 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947497 INFO  (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 3947497 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947497 INFO  (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 3947497 INFO  (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 3947497 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947497 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947497 INFO  (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 3947497 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947500 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947502 INFO  (zkConnectionManagerCallback-25207-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947502 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947502 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947503 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947505 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 3947505 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947506 DEBUG (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947507 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57998/solr ready
   [junit4]   2> 3947508 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.c.PackageManager clusterprops.json changed , version -1
   [junit4]   2> 3947527 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 3947548 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58004.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947563 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58004.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947563 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58004.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947565 INFO  (jetty-launcher-25142-thread-4) [n:127.0.0.1:58004_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.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node4/.
   [junit4]   2> 3947580 INFO  (zkConnectionManagerCallback-25210-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947580 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947580 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947592 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947595 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947598 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 3947598 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947600 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947613 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.ZkController Publish node=127.0.0.1:58003_solr as DOWN
   [junit4]   2> 3947617 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 3947617 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58003_solr
   [junit4]   2> 3947620 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947620 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947620 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947620 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947620 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947621 DEBUG (zkCallback-25209-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947621 DEBUG (zkCallback-25206-thread-1) [     ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [3])
   [junit4]   2> 3947622 INFO  (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947622 INFO  (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947622 INFO  (zkCallback-25209-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 INFO  (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 DEBUG (zkCallback-25209-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947622 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947622 INFO  (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947622 INFO  (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947622 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947623 INFO  (zkCallback-25206-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 3947623 DEBUG (zkCallback-25206-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947629 INFO  (zkConnectionManagerCallback-25217-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947629 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947629 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947630 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947632 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947633 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 3947633 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947635 DEBUG (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947637 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57998/solr ready
   [junit4]   2> 3947638 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.c.PackageManager clusterprops.json changed , version -1
   [junit4]   2> 3947666 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
   [junit4]   2> 3947695 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58003.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947709 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58003.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947709 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_solr     ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58003.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3947711 INFO  (jetty-launcher-25142-thread-2) [n:127.0.0.1:58003_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.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node2/.
   [junit4]   2> 3947765 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=4
   [junit4]   2> 3947766 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
   [junit4]   2> 3947769 INFO  (zkConnectionManagerCallback-25223-thread-1) [     ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 3947769 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
   [junit4]   2> 3947770 DEBUG (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
   [junit4]   2> 3947771 DEBUG (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ZkStateReader Loaded empty cluster properties
   [junit4]   2> 3947773 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 3947773 DEBUG (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [] -> [127.0.0.1:58003_solr, 127.0.0.1:58004_solr, 127.0.0.1:58005_solr, 127.0.0.1:58006_solr]
   [junit4]   2> 3947774 DEBUG (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [0] total [0]
   [junit4]   2> 3947776 INFO  (TEST-TestContainerReqHandler.testPluginFrompackage-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57998/solr ready
   [junit4]   2> 3947785 INFO  (qtp529625716-58623) [n:127.0.0.1:58003_solr     ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf&maxShardsPerNode=100&name=globalLoaderColl&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 3947792 INFO  (OverseerThreadFactory-16106-thread-1-processing-n:127.0.0.1:58005_solr) [n:127.0.0.1:58005_solr     ] o.a.s.c.a.c.CreateCollectionCmd Create collection globalLoaderColl
   [junit4]   2> 3947796 DEBUG (zkCallback-25209-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25206-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947797 DEBUG (zkCallback-25216-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947798 DEBUG (zkCallback-25222-thread-1) [     ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating...
   [junit4]   2> 3947799 DEBUG (zkCallback-25167-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947799 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947799 DEBUG (zkCallback-25209-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947799 DEBUG (zkCallback-25178-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947800 DEBUG (zkCallback-25206-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947800 DEBUG (zkCallback-25183-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947800 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947800 DEBUG (zkCallback-25216-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947800 DEBUG (zkCallback-25222-thread-1) [     ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3947924 INFO  (OverseerStateUpdate-72229591009394698-127.0.0.1:58005_solr-n_0000000000) [n:127.0.0.1:58005_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"globalLoaderColl",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"globalLoaderColl_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:58004/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"}
   [junit4]   2> 3947930 INFO  (OverseerStateUpdate-72229591009394698-127.0.0.1:58005_solr-n_0000000000) [n:127.0.0.1:58005_solr     ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"globalLoaderColl",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"globalLoaderColl_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:58005/solr",
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"}
   [junit4]   2> 3948056 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr    x:globalLoaderColl_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=globalLoaderColl_shard1_replica_n1&action=CREATE&numShards=2&collection=globalLoaderColl&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 3948057 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr    x:globalLoaderColl_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=globalLoaderColl_shard2_replica_n2&action=CREATE&numShards=2&collection=globalLoaderColl&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 3948057 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr    x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
   [junit4]   2> 3948060 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader Add data for [globalLoaderColl] ver [1]
   [junit4]   2> 3948060 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [1] watched [1] lazy [1] total [1]
   [junit4]   2> 3948060 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3948060 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader Add data for [globalLoaderColl] ver [1]
   [junit4]   2> 3948060 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [1] watched [1] lazy [1] total [1]
   [junit4]   2> 3948061 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3948179 DEBUG (zkCallback-25199-thread-1) [     ] o.a.s.c.c.ZkStateReader Uninteresting collection globalLoaderColl
   [junit4]   2> 3948179 DEBUG (zkCallback-25169-thread-1) [     ] o.a.s.c.c.ZkStateReader Uninteresting collection globalLoaderColl
   [junit4]   2> 3949069 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader Loading collection config from: [/collections/globalLoaderColl]
   [junit4]   2> 3949069 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader Loading collection config from: [/collections/globalLoaderColl]
   [junit4]   2> 3949071 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader path=[/configs/conf] [configName]=[conf] specified config exists in ZooKeeper
   [junit4]   2> 3949071 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader path=[/configs/conf] [configName]=[conf] specified config exists in ZooKeeper
   [junit4]   2> 3949083 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 3949083 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
   [junit4]   2> 3949111 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.s.IndexSchema [globalLoaderColl_shard2_replica_n2] Schema name=minimal
   [junit4]   2> 3949111 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.s.IndexSchema [globalLoaderColl_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 3949112 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 3949113 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'globalLoaderColl_shard2_replica_n2' using configuration from collection globalLoaderColl, trusted=true
   [junit4]   2> 3949113 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 3949113 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'globalLoaderColl_shard1_replica_n1' using configuration from collection globalLoaderColl, trusted=true
   [junit4]   2> 3949113 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58005.solr.core.globalLoaderColl.shard2.replica_n2' (registry 'solr.core.globalLoaderColl.shard2.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3949113 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.SolrCore [[globalLoaderColl_shard2_replica_n2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node1/globalLoaderColl_shard2_replica_n2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node1/./globalLoaderColl_shard2_replica_n2/data/]
   [junit4]   2> 3949113 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58004.solr.core.globalLoaderColl.shard1.replica_n1' (registry 'solr.core.globalLoaderColl.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@463dbcca
   [junit4]   2> 3949113 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.SolrCore [[globalLoaderColl_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node4/globalLoaderColl_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001/tempDir-001/node4/./globalLoaderColl_shard1_replica_n1/data/]
   [junit4]   2> 3949244 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 3949244 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 3949245 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 3949245 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 3950806 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 3950806 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3950806 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 3950806 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 3950807 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@74472f86[globalLoaderColl_shard1_replica_n1] main]
   [junit4]   2> 3950808 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader Loading collection config from: [/collections/globalLoaderColl]
   [junit4]   2> 3950808 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@3cf5c956[globalLoaderColl_shard2_replica_n2] main]
   [junit4]   2> 3950808 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader Loading collection config from: [/collections/globalLoaderColl]
   [junit4]   2> 3950809 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader path=[/configs/conf] [configName]=[conf] specified config exists in ZooKeeper
   [junit4]   2> 3950810 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader path=[/configs/conf] [configName]=[conf] specified config exists in ZooKeeper
   [junit4]   2> 3950810 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 3950810 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 3950810 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 3950811 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 3950811 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 3950811 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1642601512055078912
   [junit4]   2> 3950811 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 3950811 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1642601512055078912
   [junit4]   2> 3950814 INFO  (searcherExecutor-16130-thread-1-processing-n:127.0.0.1:58004_solr x:globalLoaderColl_shard1_replica_n1 c:globalLoaderColl s:shard1 r:core_node3) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.SolrCore [globalLoaderColl_shard1_replica_n1] Registered new searcher Searcher@74472f86[globalLoaderColl_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3950814 INFO  (searcherExecutor-16129-thread-1-processing-n:127.0.0.1:58005_solr x:globalLoaderColl_shard2_replica_n2 c:globalLoaderColl s:shard2 r:core_node4) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.SolrCore [globalLoaderColl_shard2_replica_n2] Registered new searcher Searcher@3cf5c956[globalLoaderColl_shard2_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 3950814 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader Add data for [globalLoaderColl] ver [2]
   [junit4]   2> 3950814 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [1] watched [1] lazy [1] total [1]
   [junit4]   2> 3950814 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader Add data for [globalLoaderColl] ver [2]
   [junit4]   2> 3950814 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [1] watched [1] lazy [1] total [1]
   [junit4]   2> 3950814 DEBUG (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3950814 DEBUG (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.c.ZkStateReader clusterStateSet: legacy [0] interesting [0] watched [0] lazy [1] total [1]
   [junit4]   2> 3950821 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/globalLoaderColl/terms/shard2 to Terms{values={core_node4=0}, version=0}
   [junit4]   2> 3950821 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/globalLoaderColl/leaders/shard2
   [junit4]   2> 3950821 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/globalLoaderColl/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 3950821 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/globalLoaderColl/leaders/shard1
   [junit4]   2> 3950829 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 3950829 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 3950829 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 3950829 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:58004/solr/globalLoaderColl_shard1_replica_n1/
   [junit4]   2> 3950829 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 3950829 INFO  (qtp1787951717-58633) [n:127.0.0.1:58005_solr c:globalLoaderColl s:shard2 r:core_node4 x:globalLoaderColl_shard2_replica_n2 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:58005/solr/globalLoaderColl_shard2_replica_n2/
   [junit4]   2> 3950829 INFO  (qtp1652255429-58640) [n:127.0.0.1:58004_solr c:globalLoaderColl s:shard1 r:core_node3 x:globalLoaderColl_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success

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

[     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:52829_solr, 127.0.0.1:52830_solr, 127.0.0.1:52833_solr] -> [127.0.0.1:52830_solr, 127.0.0.1:52833_solr]
   [junit4]   2> 81032 INFO  (zkCallback-1352-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
   [junit4]   2> 81032 DEBUG (zkCallback-1352-thread-1) [     ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... [127.0.0.1:52829_solr, 127.0.0.1:52830_solr, 127.0.0.1:52833_solr] -> [127.0.0.1:52830_solr, 127.0.0.1:52833_solr]
   [junit4]   2> 81034 INFO  (jetty-closer-1431-thread-1) [     ] o.a.s.c.Overseer Overseer (id=72229738747920396-127.0.0.1:52829_solr-n_0000000000) closing
   [junit4]   2> 81055 INFO  (jetty-closer-1431-thread-1) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@7b8ab623{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 81056 INFO  (jetty-closer-1431-thread-1) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5465b503{/solr,null,UNAVAILABLE}
   [junit4]   2> 81057 INFO  (jetty-closer-1431-thread-1) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 81158 INFO  (jetty-closer-1431-thread-2) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@39f48bc7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 81158 INFO  (jetty-closer-1431-thread-2) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@6e5f1133{/solr,null,UNAVAILABLE}
   [junit4]   2> 81158 INFO  (jetty-closer-1431-thread-2) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 81365 INFO  (jetty-closer-1431-thread-3) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@780fe95e{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 81365 INFO  (jetty-closer-1431-thread-3) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@30a9e9c9{/solr,null,UNAVAILABLE}
   [junit4]   2> 81365 INFO  (jetty-closer-1431-thread-3) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 81468 INFO  (jetty-closer-1431-thread-4) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@40729052{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
   [junit4]   2> 81468 INFO  (jetty-closer-1431-thread-4) [     ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@4220aedf{/solr,null,UNAVAILABLE}
   [junit4]   2> 81469 INFO  (jetty-closer-1431-thread-4) [     ] o.e.j.s.session node0 Stopped scavenging
   [junit4]   2> 81470 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 81682 WARN  (ZkTestServer Run Thread) [     ] o.a.s.c.ZkTestServer Watch limit violations:
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2>
   [junit4]   2> 9 /solr/aliases.json
   [junit4]   2> 9 /solr/clusterprops.json
   [junit4]   2> 4 /solr/security.json
   [junit4]   2>
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2>
   [junit4]   2> 36 /solr/clusterprops.json
   [junit4]   2> 9 /solr/clusterstate.json
   [junit4]   2>
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2>
   [junit4]   2> 40 /solr/live_nodes
   [junit4]   2> 9 /solr/collections
   [junit4]   2> 7 /solr/overseer/queue
   [junit4]   2>
   [junit4]   2> 82681 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52812
   [junit4]   2> 82681 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52812
   [junit4]   2> 82681 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52812
   [junit4]   2> 82682 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.e.j.s.AbstractConnector Stopped ServerConnector@3678ba2e{HTTP/1.1,[http/1.1]}{0.0.0.0:0}
   [junit4]   2> 82684 INFO  (TEST-TestContainerReqHandler.testPackageAPI-seed#[8E54BF8BC06AF872]) [     ] o.a.s.SolrTestCaseJ4 ###Ending testPackageAPI
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestContainerReqHandler -Dtests.method=testPackageAPI -Dtests.seed=8E54BF8BC06AF872 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=hr-HR -Dtests.timezone=Asia/Jayapura -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] FAILURE 5.94s J1 | TestContainerReqHandler.testPackageAPI <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: attempt: 9 Mismatch for value : '[requestHandler]' in response {
   [junit4]    >   "responseHeader":{
   [junit4]    >     "status":0,
   [junit4]    >     "QTime":0},
   [junit4]    >   "metadata":{"version":3},
   [junit4]    >   "runtimeLib":[{
   [junit4]    >       "name":"global",
   [junit4]    >       "url":"http://localhost:52811/jar3.jar",
   [junit4]    >       "60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922":"60ec88c2a2e9b409f7afc309273383810a0d07a078b482434eda9674f7e25b8adafa8a67c9913c996cbfb78a7f6ad2b9db26dbd4fe0ca4068f248d5db563f922",
   [junit4]    >       "znodeVersion":3}],
   [junit4]    >   "requestHandler":[{
   [junit4]    >       "name":"bar",
   [junit4]    >       "znodeVersion":3,
   [junit4]    >       "class":"org.apache.solr.core.RuntimeLibReqHandler",
   [junit4]    >       "package":"global"}]}
   [junit4]    > at __randomizedtesting.SeedInfo.seed([8E54BF8BC06AF872:FC5BAAC56C31A262]:0)
   [junit4]    > at org.apache.solr.handler.TestContainerReqHandler.assertResponseValues(TestContainerReqHandler.java:117)
   [junit4]    > at org.apache.solr.handler.TestContainerReqHandler.testPackageAPI(TestContainerReqHandler.java:232)
   [junit4]    > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > at java.base/java.lang.reflect.Method.invoke(Method.java:567)
   [junit4]    > at java.base/java.lang.Thread.run(Thread.java:835)
   [junit4]   2> 82690 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
   [junit4]   2> 82690 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:52812
   [junit4]   2> 82690 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:52812
   [junit4]   2> 82690 INFO  (SUITE-TestContainerReqHandler-seed#[8E54BF8BC06AF872]-worker) [     ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 52812
   [junit4]   2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.handler.TestContainerReqHandler_8E54BF8BC06AF872-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene80): {_root_=Lucene50(blocksize=128), id=FST50, desc_s=FSTOrd50}, docValues:{_version_=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1157, maxMBSortInHeap=6.53833534978041, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@e9fc465), locale=hr-HR, timezone=Asia/Jayapura
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/AdoptOpenJDK 12.0.1 (64-bit)/cpus=3,threads=1,free=71189568,total=148897792
   [junit4]   2> NOTE: All tests run in this JVM: [TestContainerReqHandler, TestContainerReqHandler]
   [junit4] Completed [4/5 (1!)] on J1 in 33.11s, 6 tests, 1 failure <<< FAILURES!

[...truncated 19 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1492: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:1019: There were test failures: 5 suites, 30 tests, 1 failure [seed: 8E54BF8BC06AF872]

Total time: 1 minute 53 seconds

[repro] Setting last failure code to 256

[repro] Failures:
[repro]   1/5 failed: org.apache.solr.handler.TestContainerReqHandler
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=1cbc5eaf51dc5e3c2bfefc014477c73db3e85b98, workspace=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX
[WARNINGS] Computing warning deltas based on reference build #5305
Recording test results
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2


---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]
Reply | Threaded
Open this post in threaded view
|

[JENKINS] Lucene-Solr-master-MacOSX (64bit/jdk-11.0.3) - Build # 5307 - Failure!

Policeman Jenkins Server-2
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5307/
Java: 64bit/jdk-11.0.3 -XX:+UseCompressedOops -XX:+UseSerialGC

All tests passed

Build Log:
[...truncated 64926 lines...]
-ecj-javadoc-lint-src:
    [mkdir] Created dir: /var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj181497807
 [ecj-lint] Compiling 69 source files to /var/folders/qg/h2dfw5s161s51l2bn79mrb7r0000gn/T/ecj181497807
 [ecj-lint] invalid Class-Path header in manifest of jar file: /Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet/jars/org.restlet-2.3.0.jar
 [ecj-lint] invalid Class-Path header in manifest of jar file: /Users/jenkins/.ivy2/cache/org.restlet.jee/org.restlet.ext.servlet/jars/org.restlet.ext.servlet-2.3.0.jar
 [ecj-lint] ----------
 [ecj-lint] 1. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 28)
 [ecj-lint] import javax.naming.InitialContext;
 [ecj-lint]       ^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The type javax.naming.InitialContext is not accessible
 [ecj-lint] ----------
 [ecj-lint] 2. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 29)
 [ecj-lint] import javax.naming.NamingException;
 [ecj-lint]       ^^^^^^^^^^^^^^^^^^^^^^^^^^^^
 [ecj-lint] The type javax.naming.NamingException is not accessible
 [ecj-lint] ----------
 [ecj-lint] 3. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 182)
 [ecj-lint] c = getFromJndi(initProps, jndiName);
 [ecj-lint]    ^^^^^^^^^^^
 [ecj-lint] The method getFromJndi(Properties, String) from the type new Callable<Connection>(){} refers to the missing type NamingException
 [ecj-lint] ----------
 [ecj-lint] 4. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 245)
 [ecj-lint] private Connection getFromJndi(final Properties initProps, final String jndiName) throws NamingException,
 [ecj-lint]                                                                                         ^^^^^^^^^^^^^^^
 [ecj-lint] NamingException cannot be resolved to a type
 [ecj-lint] ----------
 [ecj-lint] 5. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 249)
 [ecj-lint] InitialContext ctx =  new InitialContext();
 [ecj-lint] ^^^^^^^^^^^^^^
 [ecj-lint] InitialContext cannot be resolved to a type
 [ecj-lint] ----------
 [ecj-lint] 6. ERROR in /Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/contrib/dataimporthandler/src/java/org/apache/solr/handler/dataimport/JdbcDataSource.java (at line 249)
 [ecj-lint] InitialContext ctx =  new InitialContext();
 [ecj-lint]                          ^^^^^^^^^^^^^^
 [ecj-lint] InitialContext cannot be resolved to a type
 [ecj-lint] ----------
 [ecj-lint] 6 problems (6 errors)

BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:634: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/build.xml:101: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build.xml:651: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/common-build.xml:479: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:2009: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/common-build.xml:2048: Compile failed; see the compiler error output for details.

Total time: 136 minutes 36 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Skipping publisher since build result is FAILURE
Recording test results
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2


---------------------------------------------------------------------
To unsubscribe, e-mail: [hidden email]
For additional commands, e-mail: [hidden email]