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

2 tests failed.
FAILED:  
org.apache.solr.cloud.DistributedVersionInfoTest.testReplicaVersionHandling

Error Message:
IOException occured when talking to server at: 
http://127.0.0.1:57397/solr/c8n_vers_1x3_shard1_replica_n1

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when 
talking to server at: http://127.0.0.1:57397/solr/c8n_vers_1x3_shard1_replica_n1
        at 
__randomizedtesting.SeedInfo.seed([FD76B066D4A64389:218F679C76DD89C8]:0)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:657)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244)
        at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
        at 
org.apache.solr.cloud.DistributedVersionInfoTest.assertDocExists(DistributedVersionInfoTest.java:341)
        at 
org.apache.solr.cloud.DistributedVersionInfoTest.assertDocsExistInAllReplicas(DistributedVersionInfoTest.java:311)
        at 
org.apache.solr.cloud.DistributedVersionInfoTest.testReplicaVersionHandling(DistributedVersionInfoTest.java:102)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)
Caused by: org.apache.http.NoHttpResponseException: 127.0.0.1:57397 failed to 
respond
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:141)
        at 
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:56)
        at 
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:259)
        at 
org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHeader(DefaultBHttpClientConnection.java:163)
        at 
org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy.java:165)
        at 
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:273)
        at 
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:125)
        at 
org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:272)
        at 
org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java:185)
        at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89)
        at 
org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java:111)
        at 
org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttpClient.java:185)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:83)
        at 
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:56)
        at 
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:542)
        ... 45 more


FAILED:  
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([6602AB60B3000DE5:D9FDEACA6DFAED79]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testDistributions(StreamExpressionTest.java:6598)
        at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.lang.reflect.Method.invoke(Method.java:498)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.lang.Thread.run(Thread.java:748)




Build Log:
[...truncated 13329 lines...]
   [junit4] Suite: org.apache.solr.cloud.DistributedVersionInfoTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/init-core-data-001
   [junit4]   2> 2297125 WARN  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=7 numCloses=7
   [junit4]   2> 2297126 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 2297132 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
 w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 2297132 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 2297133 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 3 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001
   [junit4]   2> 2297133 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 2297134 INFO  (Thread-3771) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 2297134 INFO  (Thread-3771) [    ] o.a.s.c.ZkTestServer 
Starting server
   [junit4]   2> 2297140 ERROR (Thread-3771) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 2297244 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:57394
   [junit4]   2> 2297278 INFO  (zkConnectionManagerCallback-7352-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297295 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2297295 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2297295 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 2297299 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5088a7fc{/solr,null,AVAILABLE}
   [junit4]   2> 2297301 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@eace94c{HTTP/1.1,[http/1.1]}{127.0.0.1:57396}
   [junit4]   2> 2297301 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.e.j.s.Server Started @2301029ms
   [junit4]   2> 2297301 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=57396}
   [junit4]   2> 2297301 ERROR (jetty-launcher-7349-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2297301 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@5dc213bf{/solr,null,AVAILABLE}
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3a8b7842{HTTP/1.1,[http/1.1]}{127.0.0.1:57397}
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-01-06T08:28:18.631Z
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.e.j.s.Server Started @2301030ms
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=57397}
   [junit4]   2> 2297302 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@48e669f4{/solr,null,AVAILABLE}
   [junit4]   2> 2297302 ERROR (jetty-launcher-7349-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@6c8cef94{HTTP/1.1,[http/1.1]}{127.0.0.1:57398}
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.e.j.s.Server Started @2301031ms
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=57398}
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2297303 ERROR (jetty-launcher-7349-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 2297303 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2297304 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-01-06T08:28:18.633Z
   [junit4]   2> 2297304 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 2297304 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 2297304 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 2297304 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-01-06T08:28:18.633Z
   [junit4]   2> 2297306 INFO  (zkConnectionManagerCallback-7354-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297307 INFO  (zkConnectionManagerCallback-7356-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297308 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2297308 INFO  (zkConnectionManagerCallback-7358-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297309 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2297309 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 2297342 INFO  (jetty-launcher-7349-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57394/solr
   [junit4]   2> 2297342 INFO  (jetty-launcher-7349-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57394/solr
   [junit4]   2> 2297344 INFO  (zkConnectionManagerCallback-7364-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297344 INFO  (zkConnectionManagerCallback-7366-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297347 INFO  
(zkConnectionManagerCallback-7368-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297347 INFO  
(zkConnectionManagerCallback-7370-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297354 INFO  (jetty-launcher-7349-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57394/solr
   [junit4]   2> 2297356 INFO  (zkConnectionManagerCallback-7374-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297362 INFO  
(zkConnectionManagerCallback-7378-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297384 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2297385 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:57397_solr
   [junit4]   2> 2297386 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.Overseer Overseer 
(id=99301936232333321-127.0.0.1:57397_solr-n_0000000000) starting
   [junit4]   2> 2297396 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:57397_solr
   [junit4]   2> 2297398 INFO  
(OverseerStateUpdate-99301936232333321-127.0.0.1:57397_solr-n_0000000000) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2297475 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2297476 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 2297479 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2297480 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 2297482 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:57396_solr
   [junit4]   2> 2297484 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:57398_solr
   [junit4]   2> 2297484 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2297485 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (2)
   [junit4]   2> 2297496 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 2297506 INFO  
(zkCallback-7377-thread-2-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2297514 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57397.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297516 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (3)
   [junit4]   2> 2297520 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57397.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297520 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57397.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297521 INFO  (jetty-launcher-7349-thread-3) 
[n:127.0.0.1:57397_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.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node3/.
   [junit4]   2> 2297556 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57396.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297559 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57398.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297562 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57396.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297563 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57396.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297563 INFO  (jetty-launcher-7349-thread-1) 
[n:127.0.0.1:57396_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.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node1/.
   [junit4]   2> 2297565 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57398.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297566 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57398.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2297567 INFO  (jetty-launcher-7349-thread-2) 
[n:127.0.0.1:57398_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.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node2/.
   [junit4]   2> 2297610 INFO  (zkConnectionManagerCallback-7384-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297613 INFO  (zkConnectionManagerCallback-7388-thread-1) [    
] o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 2297615 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
   [junit4]   2> 2297616 INFO  
(SUITE-DistributedVersionInfoTest-seed#[FD76B066D4A64389]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:57394/solr ready
   [junit4]   2> 2297756 INFO  
(TEST-DistributedVersionInfoTest.testReplicaVersionHandling-seed#[FD76B066D4A64389])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting testReplicaVersionHandling
   [junit4]   2> 2297768 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
async=d8a3a393-d524-4aeb-a307-d48093f326ba&replicationFactor=3&collection.configName=conf&name=c8n_vers_1x3&nrtReplicas=3&action=CREATE&numShards=1&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297773 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={async=d8a3a393-d524-4aeb-a307-d48093f326ba&replicationFactor=3&collection.configName=conf&name=c8n_vers_1x3&nrtReplicas=3&action=CREATE&numShards=1&wt=javabin&version=2}
 status=0 QTime=6
   [junit4]   2> 2297774 INFO  (qtp432986654-24895) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2297776 INFO  (qtp432986654-24895) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2297777 INFO  
(OverseerThreadFactory-10607-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
c8n_vers_1x3
   [junit4]   2> 2297899 INFO  
(OverseerStateUpdate-99301936232333321-127.0.0.1:57397_solr-n_0000000000) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"c8n_vers_1x3",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"c8n_vers_1x3_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:57397/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2297906 INFO  
(OverseerStateUpdate-99301936232333321-127.0.0.1:57397_solr-n_0000000000) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"c8n_vers_1x3",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"c8n_vers_1x3_shard1_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:57398/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2297913 INFO  
(OverseerStateUpdate-99301936232333321-127.0.0.1:57397_solr-n_0000000000) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"c8n_vers_1x3",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"c8n_vers_1x3_shard1_replica_n4",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:57396/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 2298157 INFO  (qtp2088293427-24899) [n:127.0.0.1:57397_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048&coreNodeName=core_node3&name=c8n_vers_1x3_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin}
 status=0 QTime=3
   [junit4]   2> 2298157 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048&coreNodeName=core_node3&name=c8n_vers_1x3_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin
   [junit4]   2> 2298157 INFO  (qtp432986654-24898) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&coreNodeName=core_node5&name=c8n_vers_1x3_shard1_replica_n2&action=CREATE&numShards=1&shard=shard1&wt=javabin}
 status=0 QTime=4
   [junit4]   2> 2298158 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&coreNodeName=core_node5&name=c8n_vers_1x3_shard1_replica_n2&action=CREATE&numShards=1&shard=shard1&wt=javabin
   [junit4]   2> 2298158 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2298162 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2298163 INFO  (qtp1604844759-24884) [n:127.0.0.1:57396_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941&coreNodeName=core_node6&name=c8n_vers_1x3_shard1_replica_n4&action=CREATE&numShards=1&shard=shard1&wt=javabin}
 status=0 QTime=0
   [junit4]   2> 2298163 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr    ] o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&collection.configName=conf&newCollection=true&collection=c8n_vers_1x3&version=2&replicaType=NRT&async=d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941&coreNodeName=core_node6&name=c8n_vers_1x3_shard1_replica_n4&action=CREATE&numShards=1&shard=shard1&wt=javabin
   [junit4]   2> 2298164 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 2298166 INFO  (qtp432986654-24906) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352
   [junit4]   2> 2298166 INFO  (qtp432986654-24906) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2298286 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298287 INFO  
(zkCallback-7377-thread-2-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298287 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298287 INFO  
(zkCallback-7367-thread-2-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298287 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298288 INFO  
(zkCallback-7369-thread-2-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2298784 INFO  (qtp432986654-24907) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2298787 INFO  (qtp432986654-24907) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2299173 INFO  (qtp432986654-24886) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352
   [junit4]   2> 2299173 INFO  (qtp432986654-24886) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2299190 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.0.0
   [junit4]   2> 2299190 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.0.0
   [junit4]   2> 2299190 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.SolrConfig Using Lucene MatchVersion: 
8.0.0
   [junit4]   2> 2299205 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.s.IndexSchema 
[c8n_vers_1x3_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2299205 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.s.IndexSchema 
[c8n_vers_1x3_shard1_replica_n4] Schema name=minimal
   [junit4]   2> 2299205 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.s.IndexSchema 
[c8n_vers_1x3_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2299208 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 
with uniqueid field id
   [junit4]   2> 2299208 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 
'c8n_vers_1x3_shard1_replica_n1' using configuration from collection 
c8n_vers_1x3, trusted=true
   [junit4]   2> 2299208 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema minimal/1.1 
with uniqueid field id
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.c.CoreContainer Creating SolrCore 
'c8n_vers_1x3_shard1_replica_n2' using configuration from collection 
c8n_vers_1x3, trusted=true
   [junit4]   2> 2299208 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.s.IndexSchema Loaded schema minimal/1.1 
with uniqueid field id
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.CoreContainer Creating SolrCore 
'c8n_vers_1x3_shard1_replica_n4' using configuration from collection 
c8n_vers_1x3, trusted=true
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57397.solr.core.c8n_vers_1x3.shard1.replica_n1' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57398.solr.core.c8n_vers_1x3.shard1.replica_n2' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57396.solr.core.c8n_vers_1x3.shard1.replica_n4' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.c.SolrCore 
[[c8n_vers_1x3_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node3/c8n_vers_1x3_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node3/./c8n_vers_1x3_shard1_replica_n1/data/]
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.SolrCore 
[[c8n_vers_1x3_shard1_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node1/c8n_vers_1x3_shard1_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node1/./c8n_vers_1x3_shard1_replica_n4/data/]
   [junit4]   2> 2299209 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.c.SolrCore 
[[c8n_vers_1x3_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node2/c8n_vers_1x3_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node2/./c8n_vers_1x3_shard1_replica_n2/data/]
   [junit4]   2> 2299266 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2299267 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2299267 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2299267 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2299267 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog 
implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 2299267 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: 
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 
numVersionBuckets=65536
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: 
disabled
   [junit4]   2> 2299268 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: 
disabled
   [junit4]   2> 2299269 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6e54b8c5[c8n_vers_1x3_shard1_replica_n2] main]
   [junit4]   2> 2299269 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@35b3b595[c8n_vers_1x3_shard1_replica_n4] main]
   [junit4]   2> 2299270 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6e3ef36a[c8n_vers_1x3_shard1_replica_n1] main]
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured 
ZooKeeperStorageIO with znodeBase: /configs/conf
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.r.ManagedResourceStorage Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2299271 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at 
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.h.ReplicationHandler Commits will be 
reserved for 10000ms.
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be 
reserved for 10000ms.
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be 
reserved for 10000ms.
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.UpdateLog Could not find max version 
in index or recent updates, using new clock 1588830981954994176
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10608-thread-1-processing-n:127.0.0.1:57397_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE) 
[n:127.0.0.1:57397_solr c:c8n_vers_1x3 s:shard1 r:core_node3 
x:c8n_vers_1x3_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version 
in index or recent updates, using new clock 1588830981954994176
   [junit4]   2> 2299272 INFO  
(searcherExecutor-10616-thread-1-processing-x:c8n_vers_1x3_shard1_replica_n4 
r:core_node6 d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE 
n:127.0.0.1:57396_solr s:shard1 c:c8n_vers_1x3) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n4] Registered new searcher 
Searcher@35b3b595[c8n_vers_1x3_shard1_replica_n4] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2299273 INFO  
(searcherExecutor-10615-thread-1-processing-x:c8n_vers_1x3_shard1_replica_n2 
r:core_node5 d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE 
n:127.0.0.1:57398_solr s:shard1 c:c8n_vers_1x3) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n2] Registered new searcher 
Searcher@6e54b8c5[c8n_vers_1x3_shard1_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2299272 INFO  
(parallelCoreAdminExecutor-10611-thread-1-processing-n:127.0.0.1:57398_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352 CREATE) 
[n:127.0.0.1:57398_solr c:c8n_vers_1x3 s:shard1 r:core_node5 
x:c8n_vers_1x3_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version 
in index or recent updates, using new clock 1588830981954994176
   [junit4]   2> 2299274 INFO  
(searcherExecutor-10614-thread-1-processing-x:c8n_vers_1x3_shard1_replica_n1 
r:core_node3 d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048 CREATE 
n:127.0.0.1:57397_solr s:shard1 c:c8n_vers_1x3) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n1] Registered new searcher 
Searcher@6e3ef36a[c8n_vers_1x3_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 2299279 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ShardLeaderElectionContext Enough 
replicas found to continue.
   [junit4]   2> 2299279 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ShardLeaderElectionContext I may be 
the new leader - try and sync
   [junit4]   2> 2299279 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:57396/solr/c8n_vers_1x3_shard1_replica_n4/
   [junit4]   2> 2299279 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.PeerSync PeerSync: 
core=c8n_vers_1x3_shard1_replica_n4 url=http://127.0.0.1:57396/solr START 
replicas=[http://127.0.0.1:57397/solr/c8n_vers_1x3_shard1_replica_n1/, 
http://127.0.0.1:57398/solr/c8n_vers_1x3_shard1_replica_n2/] nUpdates=100
   [junit4]   2> 2299281 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.c.S.Request [c8n_vers_1x3_shard1_replica_n2]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2299281 INFO  (qtp2088293427-24900) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.c.S.Request [c8n_vers_1x3_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2299382 INFO  
(zkCallback-7367-thread-2-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299382 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299382 INFO  
(zkCallback-7369-thread-2-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299382 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299382 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299382 INFO  
(zkCallback-7377-thread-3-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299588 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.u.PeerSync PeerSync: 
core=c8n_vers_1x3_shard1_replica_n4 url=http://127.0.0.1:57396/solr DONE.  We 
have no versions.  sync failed.
   [junit4]   2> 2299588 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.SyncStrategy Leader's attempt to sync 
with shard failed, moving to the next candidate
   [junit4]   2> 2299588 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ShardLeaderElectionContext We failed 
sync, but we have no versions - we can't sync in that case - we were active 
before, so become leader anyway
   [junit4]   2> 2299588 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ShardLeaderElectionContext Found all 
replicas participating in election, clear LIR
   [junit4]   2> 2299597 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ShardLeaderElectionContext I am the 
new leader: http://127.0.0.1:57396/solr/c8n_vers_1x3_shard1_replica_n4/ shard1
   [junit4]   2> 2299704 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299704 INFO  
(zkCallback-7367-thread-2-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299704 INFO  
(zkCallback-7369-thread-2-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299704 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299704 INFO  
(zkCallback-7377-thread-3-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299704 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299712 INFO  
(parallelCoreAdminExecutor-10610-thread-1-processing-n:127.0.0.1:57396_solr 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941 CREATE) 
[n:127.0.0.1:57396_solr c:c8n_vers_1x3 s:shard1 r:core_node6 
x:c8n_vers_1x3_shard1_replica_n4] o.a.s.c.ZkController I am the leader, no 
recovery necessary
   [junit4]   2> 2299788 INFO  (qtp432986654-24895) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2299791 INFO  (qtp432986654-24895) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2299828 INFO  
(zkCallback-7367-thread-2-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299828 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299828 INFO  
(zkCallback-7369-thread-2-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299828 INFO  
(zkCallback-7377-thread-3-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299828 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2299828 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300181 INFO  (qtp432986654-24896) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352
   [junit4]   2> 2300181 INFO  (qtp432986654-24896) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2300408 INFO  
(zkCallback-7369-thread-2-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300408 INFO  
(zkCallback-7367-thread-2-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300409 INFO  
(zkCallback-7377-thread-3-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300409 INFO  
(zkCallback-7377-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300408 INFO  
(zkCallback-7369-thread-1-processing-n:127.0.0.1:57396_solr) 
[n:127.0.0.1:57396_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300408 INFO  
(zkCallback-7367-thread-1-processing-n:127.0.0.1:57398_solr) 
[n:127.0.0.1:57398_solr    ] o.a.s.c.c.ZkStateReader A cluster state change: 
[WatchedEvent state:SyncConnected type:NodeDataChanged 
path:/collections/c8n_vers_1x3/state.json] for collection [c8n_vers_1x3] has 
occurred - updating... (live nodes size: [3])
   [junit4]   2> 2300800 INFO  (qtp432986654-24898) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2300801 INFO  (qtp432986654-24898) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=1
   [junit4]   2> 2301192 INFO  (qtp432986654-24906) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352
   [junit4]   2> 2301193 INFO  (qtp432986654-24906) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731141199352&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2301196 INFO  (qtp2088293427-24901) [n:127.0.0.1:57397_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048
   [junit4]   2> 2301196 INFO  (qtp2088293427-24901) [n:127.0.0.1:57397_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731133443048&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2301199 INFO  (qtp1604844759-24885) [n:127.0.0.1:57396_solr    
] o.a.s.h.a.CoreAdminOperation Checking request status for : 
d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941
   [junit4]   2> 2301200 INFO  (qtp1604844759-24885) [n:127.0.0.1:57396_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&requestid=d8a3a393-d524-4aeb-a307-d48093f326ba210731148154941&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2301208 INFO  
(OverseerThreadFactory-10607-thread-1-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2301798 INFO  
(OverseerCollectionConfigSetProcessor-99301936232333321-127.0.0.1:57397_solr-n_0000000000)
 [n:127.0.0.1:57397_solr    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 2301812 INFO  (qtp432986654-24907) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2301815 INFO  (qtp432986654-24907) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=REQUESTSTATUS&wt=javabin&version=2}
 status=0 QTime=2
   [junit4]   2> 2301816 INFO  (qtp432986654-24886) [n:127.0.0.1:57398_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with 
params 
requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=DELETESTATUS&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 2301817 INFO  (qtp432986654-24886) [n:127.0.0.1:57398_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={requestid=d8a3a393-d524-4aeb-a307-d48093f326ba&action=DELETESTATUS&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2301827 INFO  (qtp1604844759-24888) [n:127.0.0.1:57396_solr    
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={core=c8n_vers_1x3_shard1_replica_n4&action=STATUS&indexInfo=true&wt=javabin&version=2}
 status=0 QTime=0
   [junit4]   2> 2302830 INFO  
(TEST-DistributedVersionInfoTest.testReplicaVersionHandling-seed#[FD76B066D4A64389])
 [    ] o.a.s.c.DistributedVersionInfoTest Sending RELOAD command for 
c8n_vers_1x3
   [junit4]   2> 2302831 INFO  (qtp1604844759-24890) [n:127.0.0.1:57396_solr    
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :reload with params 
name=c8n_vers_1x3&action=RELOAD&wt=javabin&version=2 and sendToOCPQueue=true
   [junit4]   2> 2302834 INFO  
(OverseerThreadFactory-10607-thread-2-processing-n:127.0.0.1:57397_solr) 
[n:127.0.0.1:57397_solr    ] o.a.s.c.OverseerCollectionMessageHandler Executing 
Collection Cmd : action=RELOAD
   [junit4]   2> 2302873 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2302873 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr    
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2302873 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr    
] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 2302881 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr    
] o.a.s.s.IndexSchema [c8n_vers_1x3_shard1_replica_n1] Schema name=minimal
   [junit4]   2> 2302881 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.s.IndexSchema [c8n_vers_1x3_shard1_replica_n2] Schema name=minimal
   [junit4]   2> 2302884 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2302884 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr    
] o.a.s.c.CoreContainer Reloading SolrCore 'c8n_vers_1x3_shard1_replica_n2' 
using configuration from collection c8n_vers_1x3
   [junit4]   2> 2302884 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr    
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2302884 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr    
] o.a.s.c.CoreContainer Reloading SolrCore 'c8n_vers_1x3_shard1_replica_n1' 
using configuration from collection c8n_vers_1x3
   [junit4]   2> 2302886 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr    
] o.a.s.s.IndexSchema [c8n_vers_1x3_shard1_replica_n4] Schema name=minimal
   [junit4]   2> 2302887 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr    
] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
   [junit4]   2> 2302887 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr    
] o.a.s.c.CoreContainer Reloading SolrCore 'c8n_vers_1x3_shard1_replica_n4' 
using configuration from collection c8n_vers_1x3
   [junit4]   2> 2303083 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57398.solr.core.c8n_vers_1x3.shard1.replica_n2' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2303084 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.c.SolrCore [[c8n_vers_1x3_shard1_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node2/c8n_vers_1x3_shard1_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node2/./c8n_vers_1x3_shard1_replica_n2/data/]
   [junit4]   2> 2303090 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57397.solr.core.c8n_vers_1x3.shard1.replica_n1' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2303090 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.c.SolrCore [[c8n_vers_1x3_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node3/c8n_vers_1x3_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node3/./c8n_vers_1x3_shard1_replica_n1/data/]
   [junit4]   2> 2303092 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_57396.solr.core.c8n_vers_1x3.shard1.replica_n4' (registry 
'solr.core.c8n_vers_1x3.shard1.replica_n4') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@7620c0a4
   [junit4]   2> 2303092 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.c.SolrCore [[c8n_vers_1x3_shard1_replica_n4] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node1/c8n_vers_1x3_shard1_replica_n4],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.DistributedVersionInfoTest_FD76B066D4A64389-001/tempDir-001/node1/./c8n_vers_1x3_shard1_replica_n4/data/]
   [junit4]   2> 2303140 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@44684f60
   [junit4]   2> 2303140 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.c8n_vers_1x3.shard1.replica_n2, tag=1147686752
   [junit4]   2> 2303140 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5833e2c3: rootName = 
solr_57398, domain = solr.core.c8n_vers_1x3.shard1.replica_n2, service url = 
null, agent id = null] for registry solr.core.c8n_vers_1x3.shard1.replica_n2 / 
com.codahale.metrics.MetricRegistry@c973478
   [junit4]   2> 2303144 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n4]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@54a16bc9
   [junit4]   2> 2303144 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.c.SolrCore [c8n_vers_1x3_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@95ed820
   [junit4]   2> 2303144 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.c8n_vers_1x3.shard1.replica_n4, tag=1419865033
   [junit4]   2> 2303144 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.c8n_vers_1x3.shard1.replica_n1, tag=157210656
   [junit4]   2> 2303144 INFO  (qtp1604844759-24891) [n:127.0.0.1:57396_solr 
c:c8n_vers_1x3 s:shard1 r:core_node6 x:c8n_vers_1x3_shard1_replica_n4] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@13da9970: rootName = 
solr_57396, domain = solr.core.c8n_vers_1x3.shard1.replica_n4, service url = 
null, agent id = null] for registry solr.core.c8n_vers_1x3.shard1.replica_n4 / 
com.codahale.metrics.MetricRegistry@12b9ff39
   [junit4]   2> 2303144 INFO  (qtp2088293427-24902) [n:127.0.0.1:57397_solr 
c:c8n_vers_1x3 s:shard1 r:core_node3 x:c8n_vers_1x3_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@6eb89468: rootName = 
solr_57397, domain = solr.core.c8n_vers_1x3.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.c8n_vers_1x3.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@2842b60b
   [junit4]   2> 2303217 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.c8n_vers_1x3.shard1.leader, tag=1147686752
   [junit4]   2> 2303218 ERROR (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Error handling 
'reload' action
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$2(CoreAdminOperation.java:113)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:736)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:717)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:498)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
   [junit4]   2>        at 
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:426)
   [junit4]   2>        at 
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
   [junit4]   2>        at 
org.eclipse.jetty.server.Server.handle(Server.java:534)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
   [junit4]   2>        at 
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
   [junit4]   2>        at 
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:283)
   [junit4]   2>        at 
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:108)
   [junit4]   2>        at 
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
   [junit4]   2>        at 
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: Unable to 
reload core [c8n_vers_1x3_shard1_replica_n2]
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1309)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$2(CoreAdminOperation.java:111)
   [junit4]   2>        ... 33 more
   [junit4]   2> Caused by: org.apache.solr.common.SolrException: invalid API 
spec: apispec/emptySpec.json
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:1008)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.reload(SolrCore.java:656)
   [junit4]   2>        at 
org.apache.solr.core.CoreContainer.reload(CoreContainer.java:1291)
   [junit4]   2>        ... 34 more
   [junit4]   2> Caused by: java.lang.RuntimeException: invalid API spec: 
apispec/emptySpec.json
   [junit4]   2>        at 
org.apache.solr.common.util.ValidatingJsonMap.parse(ValidatingJsonMap.java:318)
   [junit4]   2>        at 
org.apache.solr.common.util.Utils.lambda$getSpec$0(Utils.java:427)
   [junit4]   2>        at org.apache.solr.api.Api.getSpec(Api.java:65)
   [junit4]   2>        at org.apache.solr.api.ApiBag.register(ApiBag.java:73)
   [junit4]   2>        at 
org.apache.solr.core.PluginBag.put(PluginBag.java:217)
   [junit4]   2>        at 
org.apache.solr.core.PluginBag.init(PluginBag.java:274)
   [junit4]   2>        at 
org.apache.solr.core.RequestHandlers.initHandlersFromConfig(RequestHandlers.java:130)
   [junit4]   2>        at 
org.apache.solr.core.SolrCore.<init>(SolrCore.java:966)
   [junit4]   2>        ... 36 more
   [junit4]   2> 
   [junit4]   2> 2303219 INFO  (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={core=c8n_vers_1x3_shard1_replica_n2&qt=/admin/cores&action=RELOAD&wt=javabin&version=2}
 status=500 QTime=384
   [junit4]   2> 2303219 ERROR (qtp432986654-24894) [n:127.0.0.1:57398_solr 
c:c8n_vers_1x3 s:shard1 r:core_node5 x:c8n_vers_1x3_shard1_replica_n2] 
o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: Error handling 
'reload' action
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$2(CoreAdminOperation.java:113)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:384)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:389)
   [junit4]   2>        at 
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:174)
   [junit4]   2>        at 
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:177)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdmin(HttpSolrCall.java:736)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:717)
   [junit4]   2>        at 
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:498)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
   [junit4]   2>        at 
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:326)
   [junit4]   2>        at 
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1759)
   [jun

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

 Updated live nodes from ZooKeeper... (1) -> (0)
   [junit4]   2> 248096 INFO  (jetty-closer-167-thread-3) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, 
tag=null
   [junit4]   2> 248097 INFO  (coreCloseExecutor-530-thread-1) 
[n:127.0.0.1:62474_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[collection1_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@278c540
   [junit4]   2> 248097 INFO  (coreCloseExecutor-530-thread-1) 
[n:127.0.0.1:62474_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.collection1.shard1.replica_n1, tag=41469248
   [junit4]   2> 248097 INFO  (coreCloseExecutor-530-thread-1) 
[n:127.0.0.1:62474_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@5303bf8f: rootName = 
solr_62474, domain = solr.core.collection1.shard1.replica_n1, service url = 
null, agent id = null] for registry solr.core.collection1.shard1.replica_n1 / 
com.codahale.metrics.MetricRegistry@6127d16a
   [junit4]   2> 248099 INFO  
(zkCallback-194-thread-1-processing-n:127.0.0.1:62474_solr) 
[n:127.0.0.1:62474_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:62474_solr
   [junit4]   2> 248116 INFO  (coreCloseExecutor-530-thread-1) 
[n:127.0.0.1:62474_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard1.leader, tag=41469248
   [junit4]   2> 248116 INFO  (jetty-closer-167-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@32a33642{/solr,null,UNAVAILABLE}
   [junit4]   2> 248119 INFO  (jetty-closer-167-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@3584b768{/solr,null,UNAVAILABLE}
   [junit4]   2> 248123 INFO  (jetty-closer-167-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@22383585{/solr,null,UNAVAILABLE}
   [junit4]   2> 248139 ERROR 
(SUITE-StreamExpressionTest-seed#[6602AB60B3000DE5]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 248140 INFO  
(SUITE-StreamExpressionTest-seed#[6602AB60B3000DE5]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:62471 62471
   [junit4]   2> 248163 INFO  (Thread-116) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:62471 62471
   [junit4]   2> 248386 WARN  (Thread-116) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        100     /solr/aliases.json
   [junit4]   2>        100     /solr/clusterprops.json
   [junit4]   2>        10      /solr/configs/conf
   [junit4]   2>        7       /solr/configs/ml
   [junit4]   2>        4       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        100     /solr/clusterstate.json
   [junit4]   2>        38      
/solr/collections/destinationCollection/state.json
   [junit4]   2>        28      
/solr/collections/parallelDestinationCollection1/state.json
   [junit4]   2>        20      
/solr/collections/parallelDestinationCollection/state.json
   [junit4]   2>        10      /solr/collections/mainCorpus1/state.json
   [junit4]   2>        10      /solr/collections/destination/state.json
   [junit4]   2>        10      /solr/collections/destination1/state.json
   [junit4]   2>        10      /solr/collections/collection1/state.json
   [junit4]   2>        10      /solr/collections/workQueue1/state.json
   [junit4]   2>        10      /solr/collections/workQueue/state.json
   [junit4]   2>        10      /solr/collections/uknownCollection/state.json
   [junit4]   2>        10      /solr/collections/modelCollection/state.json
   [junit4]   2>        10      
/solr/collections/checkpointCollection/state.json
   [junit4]   2>        10      /solr/collections/mainCorpus/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        100     /solr/live_nodes
   [junit4]   2>        100     /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_6602AB60B3000DE5-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{expr_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 name_s=PostingsFormat(name=Asserting), 
iteration_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 terms_ss=PostingsFormat(name=MockRandom), 
join2_s=PostingsFormat(name=MockRandom), 
multiDefault=PostingsFormat(name=MockRandom), 
subject=PostingsFormat(name=MockRandom), a_f=PostingsFormat(name=MockRandom), 
intDefault=FST50, a2_s=PostingsFormat(name=Asserting), falseNegative_i=FST50, 
a_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 
level1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 body_t=PostingsFormat(name=Asserting), a_s=PostingsFormat(name=Asserting), 
a_t=FST50, 
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 text=PostingsFormat(name=Asserting), alpha_d=PostingsFormat(name=Asserting), 
i_multi=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 idf_d=PostingsFormat(name=MockRandom), b_ls=PostingsFormat(name=MockRandom), 
checkpoint_ss=PostingsFormat(name=Asserting), 
test_t=PostingsFormat(name=Asserting), ident_s=PostingsFormat(name=MockRandom), 
order_i=PostingsFormat(name=MockRandom), 
error_d=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 side_s=PostingsFormat(name=Asserting), 
truePositive_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 miles_i=PostingsFormat(name=MockRandom), field_s=FST50, 
price_f=PostingsFormat(name=MockRandom), a1_s=PostingsFormat(name=MockRandom), 
join1_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 join3_i=PostingsFormat(name=Asserting), 
test_i=PostingsFormat(name=MockRandom), falsePositive_i=FST50, 
field_i=PostingsFormat(name=MockRandom), 
s_multi=PostingsFormat(name=Asserting), col_s=PostingsFormat(name=MockRandom), 
a_ss=FST50, level2_s=FST50, score_f=PostingsFormat(name=Asserting), 
tv_text=FST50, term_s=PostingsFormat(name=MockRandom), 
text_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 timestamp=FST50, idfs_ds=FST50, weights_ds=PostingsFormat(name=Asserting), 
featureSet_s=PostingsFormat(name=MockRandom), 
trueNegative_i=PostingsFormat(name=Asserting), 
index_i=PostingsFormat(name=MockRandom), 
test_dt=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
 out_i=PostingsFormat(name=MockRandom), 
whitetok=PostingsFormat(name=Asserting), _version_=FST50}, 
docValues:{expr_s=DocValuesFormat(name=Lucene70), 
name_s=DocValuesFormat(name=Direct), 
iteration_i=DocValuesFormat(name=Lucene70), 
terms_ss=DocValuesFormat(name=Asserting), 
join2_s=DocValuesFormat(name=Asserting), 
multiDefault=DocValuesFormat(name=Asserting), 
a_f=DocValuesFormat(name=Asserting), intDefault=DocValuesFormat(name=Memory), 
a2_s=DocValuesFormat(name=Direct), 
falseNegative_i=DocValuesFormat(name=Memory), 
a_i=DocValuesFormat(name=Lucene70), level1_s=DocValuesFormat(name=Lucene70), 
a_s=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene70), 
alpha_d=DocValuesFormat(name=Direct), i_multi=DocValuesFormat(name=Lucene70), 
idf_d=DocValuesFormat(name=Asserting), b_ls=DocValuesFormat(name=Asserting), 
checkpoint_ss=DocValuesFormat(name=Direct), 
ident_s=DocValuesFormat(name=Asserting), 
order_i=DocValuesFormat(name=Asserting), 
error_d=DocValuesFormat(name=Lucene70), side_s=DocValuesFormat(name=Direct), 
truePositive_i=DocValuesFormat(name=Lucene70), 
miles_i=DocValuesFormat(name=Asserting), field_s=DocValuesFormat(name=Memory), 
price_f=DocValuesFormat(name=Asserting), a1_s=DocValuesFormat(name=Asserting), 
join1_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Direct), 
test_i=DocValuesFormat(name=Asserting), 
falsePositive_i=DocValuesFormat(name=Memory), 
field_i=DocValuesFormat(name=Asserting), s_multi=DocValuesFormat(name=Direct), 
col_s=DocValuesFormat(name=Asserting), a_ss=DocValuesFormat(name=Memory), 
level2_s=DocValuesFormat(name=Memory), score_f=DocValuesFormat(name=Direct), 
term_s=DocValuesFormat(name=Asserting), text_s=DocValuesFormat(name=Lucene70), 
timestamp=DocValuesFormat(name=Memory), idfs_ds=DocValuesFormat(name=Memory), 
weights_ds=DocValuesFormat(name=Direct), 
featureSet_s=DocValuesFormat(name=Asserting), 
trueNegative_i=DocValuesFormat(name=Direct), 
index_i=DocValuesFormat(name=Asserting), 
test_dt=DocValuesFormat(name=Lucene70), out_i=DocValuesFormat(name=Asserting), 
_version_=DocValuesFormat(name=Memory)}, maxPointsInLeafNode=349, 
maxMBSortInHeap=5.455579604991345, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7e4c78c6),
 locale=hu, timezone=Asia/Famagusta
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=104700856,total=223408128
   [junit4]   2> NOTE: All tests run in this JVM: [SolrExampleJettyTest, 
ModuloEvaluatorTest, TestZkConfigManager, HttpSolrClientConPoolTest, 
RoundEvaluatorTest, BasicHttpSolrClientTest, TestValidatingJsonMap, 
TestV2Request, SolrExceptionTest, TestClusteringResponse, 
SquareRootEvaluatorTest, CloudSolrClientTest, TestSuggesterResponse, 
OperationsTest, CoalesceEvaluatorTest, GreaterThanEqualToEvaluatorTest, 
StreamExpressionTest]
   [junit4] Completed [123/146 (1!)] on J1 in 147.16s, 148 tests, 1 failure <<< 
FAILURES!

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

Reply via email to