Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/521/
4 tests failed. FAILED: org.apache.solr.analytics.facet.ValueFacetTest.meanTest Error Message: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] Stack Trace: java.lang.RuntimeException: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] at __randomizedtesting.SeedInfo.seed([A3EB4FF7DD019AFA:A96D9F52E3F31585]:0) at org.apache.solr.analytics.facet.SolrAnalyticsFacetTestCase.testGrouping(SolrAnalyticsFacetTestCase.java:77) at org.apache.solr.analytics.facet.ValueFacetTest.meanTest(ValueFacetTest.java:338) 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: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] at org.apache.solr.analytics.SolrAnalyticsTestCase.queryCloudObject(SolrAnalyticsTestCase.java:147) at org.apache.solr.analytics.SolrAnalyticsTestCase.testResults(SolrAnalyticsTestCase.java:98) at org.apache.solr.analytics.SolrAnalyticsTestCase.testAnalytics(SolrAnalyticsTestCase.java:162) at org.apache.solr.analytics.SolrAnalyticsTestCase.testGroupingSorted(SolrAnalyticsTestCase.java:260) at org.apache.solr.analytics.SolrAnalyticsTestCase.testGrouping(SolrAnalyticsTestCase.java:205) at org.apache.solr.analytics.facet.SolrAnalyticsFacetTestCase.testGrouping(SolrAnalyticsFacetTestCase.java:75) ... 40 more Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1105) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:885) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:818) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.analytics.SolrAnalyticsTestCase.queryCloudObject(SolrAnalyticsTestCase.java:145) ... 45 more Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37327/solr/collection1: java.lang.IndexOutOfBoundsException: Index: 0, Size: 0 at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) 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.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) ... 50 more FAILED: junit.framework.TestSuite.org.apache.solr.analytics.legacy.facet.LegacyFieldFacetCloudTest Error Message: Error from server at http://127.0.0.1:43691/solr: KeeperErrorCode = Session expired for /configs/conf Stack Trace: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:43691/solr: KeeperErrorCode = Session expired for /configs/conf at __randomizedtesting.SeedInfo.seed([A3EB4FF7DD019AFA]:0) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) 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.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1105) at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:885) at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:818) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) at org.apache.solr.analytics.legacy.LegacyAbstractAnalyticsCloudTest.setupCollection(LegacyAbstractAnalyticsCloudTest.java:50) 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$6.evaluate(RandomizedRunner.java:874) 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) FAILED: org.apache.solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest.testAsyncRequests Error Message: Could not load collection from ZK: testAsyncOperations Stack Trace: org.apache.solr.common.SolrException: Could not load collection from ZK: testAsyncOperations at __randomizedtesting.SeedInfo.seed([9E72F6703758B7F3:7A36CAC791F0F92C]:0) at org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1236) at org.apache.solr.common.cloud.ZkStateReader$LazyCollectionRef.get(ZkStateReader.java:674) at org.apache.solr.common.cloud.ClusterState.getCollectionOrNull(ClusterState.java:148) at org.apache.solr.common.cloud.ClusterState.getCollectionOrNull(ClusterState.java:131) at org.apache.solr.common.cloud.ClusterState.getCollection(ClusterState.java:117) at org.apache.solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest.testAsyncRequests(CollectionsAPIAsyncDistributedZkTest.java:144) 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.zookeeper.KeeperException$SessionExpiredException: KeeperErrorCode = Session expired for /collections/testAsyncOperations/state.json at org.apache.zookeeper.KeeperException.create(KeeperException.java:130) at org.apache.zookeeper.KeeperException.create(KeeperException.java:54) at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1215) at org.apache.solr.common.cloud.SolrZkClient.lambda$getData$5(SolrZkClient.java:340) at org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60) at org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:340) at org.apache.solr.common.cloud.ZkStateReader.fetchCollectionState(ZkStateReader.java:1248) at org.apache.solr.common.cloud.ZkStateReader.getCollectionLive(ZkStateReader.java:1234) ... 44 more FAILED: org.apache.solr.cloud.autoscaling.ComputePlanActionTest.testNodeLost Error Message: org.apache.solr.common.SolrException: Stack Trace: org.apache.solr.common.SolrException: org.apache.solr.common.SolrException: at __randomizedtesting.SeedInfo.seed([9E72F6703758B7F3:2167388EB4B2D275]:0) at org.apache.solr.common.cloud.rule.ImplicitSnitch.getTags(ImplicitSnitch.java:78) at org.apache.solr.client.solrj.impl.SolrClientNodeStateProvider.getNodeValues(SolrClientNodeStateProvider.java:111) at org.apache.solr.cloud.autoscaling.ComputePlanActionTest.printState(ComputePlanActionTest.java:139) 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$10.evaluate(RandomizedRunner.java:992) 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.solr.common.SolrException: at org.apache.solr.client.solrj.impl.SolrClientNodeStateProvider$AutoScalingSnitch.getRemoteInfo(SolrClientNodeStateProvider.java:250) at org.apache.solr.common.cloud.rule.ImplicitSnitch.getTags(ImplicitSnitch.java:76) ... 39 more Caused by: org.apache.solr.client.solrj.SolrServerException: Server refused connection at: http://127.0.0.1:44452/solr at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:650) 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.client.solrj.impl.SolrClientNodeStateProvider$ClientSnitchCtx.invoke(SolrClientNodeStateProvider.java:292) at org.apache.solr.client.solrj.impl.SolrClientNodeStateProvider$AutoScalingSnitch.getRemoteInfo(SolrClientNodeStateProvider.java:227) ... 40 more Caused by: org.apache.http.conn.HttpHostConnectException: Connect to 127.0.0.1:44452 [/127.0.0.1] failed: Connection refused (Connection refused) at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:159) at org.apache.http.impl.conn.PoolingHttpClientConnectionManager.connect(PoolingHttpClientConnectionManager.java:359) at org.apache.http.impl.execchain.MainClientExec.establishRoute(MainClientExec.java:381) at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.java:237) 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 Caused by: java.net.ConnectException: Connection refused (Connection refused) at java.net.PlainSocketImpl.socketConnect(Native Method) at java.net.AbstractPlainSocketImpl.doConnect(AbstractPlainSocketImpl.java:350) at java.net.AbstractPlainSocketImpl.connectToAddress(AbstractPlainSocketImpl.java:206) at java.net.AbstractPlainSocketImpl.connect(AbstractPlainSocketImpl.java:188) at java.net.SocksSocketImpl.connect(SocksSocketImpl.java:392) at java.net.Socket.connect(Socket.java:589) at org.apache.http.conn.socket.PlainConnectionSocketFactory.connectSocket(PlainConnectionSocketFactory.java:75) at org.apache.http.impl.conn.DefaultHttpClientConnectionOperator.connect(DefaultHttpClientConnectionOperator.java:142) ... 55 more Build Log: [...truncated 1790 lines...] [junit4] JVM J1: stdout was not empty, see: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/build/core/test/temp/junit4-J1-20180321_053034_4167002487189681333826.sysout [junit4] >>> JVM J1 emitted unexpected output (verbatim) ---- [junit4] codec: FastDecompressionCompressingStoredFields, pf: Direct, dvf: Lucene70 [junit4] <<< JVM J1: EOF ---- [...truncated 10948 lines...] [junit4] Suite: org.apache.solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest [junit4] 2> 918438 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/init-core-data-001 [junit4] 2> 918438 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true [junit4] 2> 918439 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN) [junit4] 2> 918440 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 2 servers in /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001 [junit4] 2> 918440 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 918440 INFO (Thread-814) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 918440 INFO (Thread-814) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 918458 ERROR (Thread-814) [ ] 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> 918540 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:41284 [junit4] 2> 918558 INFO (zkConnectionManagerCallback-1066-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918562 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 918563 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T17:27:37-04:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8 [junit4] 2> 918564 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 918564 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 918564 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.session Scavenging every 600000ms [junit4] 2> 918564 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4a3f0a5d{/solr,null,AVAILABLE} [junit4] 2> 918565 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0 [junit4] 2> 918565 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 918565 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.session Scavenging every 660000ms [junit4] 2> 918566 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4b2324c4{/solr,null,AVAILABLE} [junit4] 2> 918580 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@49f68141{HTTP/1.1,[http/1.1]}{127.0.0.1:46256} [junit4] 2> 918580 INFO (jetty-launcher-1063-thread-1) [ ] o.e.j.s.Server Started @928822ms [junit4] 2> 918599 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@4cede3ea{HTTP/1.1,[http/1.1]}{127.0.0.1:39783} [junit4] 2> 918599 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=46256} [junit4] 2> 918599 INFO (jetty-launcher-1063-thread-2) [ ] o.e.j.s.Server Started @928842ms [junit4] 2> 918599 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=39783} [junit4] 2> 918599 ERROR (jetty-launcher-1063-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 918599 ERROR (jetty-launcher-1063-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 918599 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0 [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 7.4.0 [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-21T07:07:43.055Z [junit4] 2> 918600 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2018-03-21T07:07:43.055Z [junit4] 2> 918602 INFO (zkConnectionManagerCallback-1069-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918602 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 918656 INFO (zkConnectionManagerCallback-1070-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918668 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 918687 INFO (jetty-launcher-1063-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41284/solr [junit4] 2> 918687 INFO (jetty-launcher-1063-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:41284/solr [junit4] 2> 918749 INFO (zkConnectionManagerCallback-1078-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918749 INFO (zkConnectionManagerCallback-1076-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918755 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ] o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 0x100eba512290004, likely client has closed socket [junit4] 2> 918758 INFO (zkConnectionManagerCallback-1082-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 918770 INFO (zkConnectionManagerCallback-1080-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 919029 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 919038 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:46256_solr [junit4] 2> 919039 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.Overseer Overseer (id=72316688244736006-127.0.0.1:46256_solr-n_0000000000) starting [junit4] 2> 919055 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 919056 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:39783_solr [junit4] 2> 919100 INFO (zkConnectionManagerCallback-1088-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 919101 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 919102 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41284/solr ready [junit4] 2> 919144 INFO (zkCallback-1081-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 919144 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 919177 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46256_solr [junit4] 2> 919269 INFO (zkCallback-1087-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 919285 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 919285 INFO (zkCallback-1081-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 924752 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46256.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924769 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39783.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924790 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46256.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924791 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46256.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924792 INFO (jetty-launcher-1063-thread-1) [n:127.0.0.1:46256_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node1/. [junit4] 2> 924797 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39783.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924797 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39783.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 924798 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node2/. [junit4] 2> 924821 INFO (zkConnectionManagerCallback-1092-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 924822 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 924823 INFO (jetty-launcher-1063-thread-2) [n:127.0.0.1:39783_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41284/solr ready [junit4] 2> 924906 INFO (zkConnectionManagerCallback-1094-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 924909 INFO (zkConnectionManagerCallback-1098-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 924910 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2) [junit4] 2> 924911 INFO (SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[9E72F6703758B7F3]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:41284/solr ready [junit4] 2> 924937 INFO (TEST-CollectionsAPIAsyncDistributedZkTest.testSolrJAPICalls-seed#[9E72F6703758B7F3]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testSolrJAPICalls [junit4] 2> 924940 INFO (qtp1254131660-4258) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=211fa39a-6065-4db5-a8ab-afef4a1f49a5&replicationFactor=1&collection.configName=conf1&name=testasynccollectioncreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 924943 INFO (qtp1254131660-4258) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=211fa39a-6065-4db5-a8ab-afef4a1f49a5&replicationFactor=1&collection.configName=conf1&name=testasynccollectioncreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=2 [junit4] 2> 924955 INFO (OverseerThreadFactory-2241-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testasynccollectioncreation [junit4] 2> 924956 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 924956 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 925110 INFO (OverseerStateUpdate-72316688244736006-127.0.0.1:46256_solr-n_0000000000) [n:127.0.0.1:46256_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testasynccollectioncreation", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testasynccollectioncreation_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:39783/solr";, [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"} [junit4] 2> 925218 INFO (qtp1271735560-4263) [n:127.0.0.1:39783_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testasynccollectioncreation&version=2&replicaType=NRT&async=211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821&coreNodeName=core_node2&name=testasynccollectioncreation_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin} status=0 QTime=0 [junit4] 2> 925218 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&newCollection=true&collection=testasynccollectioncreation&version=2&replicaType=NRT&async=211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821&coreNodeName=core_node2&name=testasynccollectioncreation_shard1_replica_n1&action=CREATE&numShards=1&shard=shard1&wt=javabin [junit4] 2> 925218 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 925218 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 [junit4] 2> 925239 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=20 [junit4] 2> 925360 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 925361 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 925958 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 925959 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 926240 INFO (qtp1271735560-4272) [n:127.0.0.1:39783_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 [junit4] 2> 926240 INFO (qtp1271735560-4272) [n:127.0.0.1:39783_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 926264 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0 [junit4] 2> 926283 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.s.IndexSchema [testasynccollectioncreation_shard1_replica_n1] Schema name=minimal [junit4] 2> 926293 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 926294 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'testasynccollectioncreation_shard1_replica_n1' using configuration from collection testasynccollectioncreation, trusted=true [junit4] 2> 926294 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39783.solr.core.testasynccollectioncreation.shard1.replica_n1' (registry 'solr.core.testasynccollectioncreation.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 926294 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 926294 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SolrCore [[testasynccollectioncreation_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node2/testasynccollectioncreation_shard1_replica_n1], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node2/./testasynccollectioncreation_shard1_replica_n1/data/] [junit4] 2> 926347 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 926348 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 926349 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 926349 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 926350 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@64c6d907[testasynccollectioncreation_shard1_replica_n1] main] [junit4] 2> 926351 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 926351 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 926351 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 926352 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1595530093062520832 [junit4] 2> 926352 INFO (searcherExecutor-2246-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n1 r:core_node2 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE n:127.0.0.1:39783_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SolrCore [testasynccollectioncreation_shard1_replica_n1] Registered new searcher Searcher@64c6d907[testasynccollectioncreation_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 926377 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testasynccollectioncreation/terms/shard1 to Terms{values={core_node2=0}, version=0} [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:39783/solr/testasynccollectioncreation_shard1_replica_n1/ [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:39783/solr/testasynccollectioncreation_shard1_replica_n1/ has no replicas [junit4] 2> 926388 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 926399 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:39783/solr/testasynccollectioncreation_shard1_replica_n1/ shard1 [junit4] 2> 926501 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 926501 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 926550 INFO (parallelCoreAdminExecutor-2243-thread-1-processing-n:127.0.0.1:39783_solr 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 CREATE) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 926654 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 926654 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 926960 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 926961 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 927242 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821 [junit4] 2> 927242 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a53953470501035821&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 927244 INFO (OverseerThreadFactory-2241-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_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> 927962 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 927963 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 927964 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=DELETESTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 927964 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=211fa39a-6065-4db5-a8ab-afef4a1f49a5&action=DELETESTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 927965 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params async=37beb43e-fd77-4251-89c3-3605330f5f48&replicationFactor=1&collection.configName=conf1&name=testasynccollectioncreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 927981 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=37beb43e-fd77-4251-89c3-3605330f5f48&replicationFactor=1&collection.configName=conf1&name=testasynccollectioncreation&nrtReplicas=1&action=CREATE&numShards=1&wt=javabin&version=2} status=0 QTime=15 [junit4] 2> 927981 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 928006 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=24 [junit4] 2> 928007 INFO (OverseerCollectionConfigSetProcessor-72316688244736006-127.0.0.1:46256_solr-n_0000000000) [n:127.0.0.1:46256_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> 928007 INFO (OverseerThreadFactory-2241-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection testasynccollectioncreation [junit4] 2> 928068 ERROR (OverseerThreadFactory-2241-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.OverseerCollectionMessageHandler Collection: testasynccollectioncreation operation: create failed:org.apache.solr.common.SolrException: collection already exists: testasynccollectioncreation [junit4] 2> at org.apache.solr.cloud.api.collections.CreateCollectionCmd.call(CreateCollectionCmd.java:106) [junit4] 2> at org.apache.solr.cloud.api.collections.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:252) [junit4] 2> at org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:469) [junit4] 2> at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1149) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:624) [junit4] 2> at java.lang.Thread.run(Thread.java:748) [junit4] 2> [junit4] 2> 928072 INFO (OverseerThreadFactory-2241-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 929069 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 929071 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 929071 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=DELETESTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 929073 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=37beb43e-fd77-4251-89c3-3605330f5f48&action=DELETESTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 929074 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params async=758c7f62-4fb9-4491-82e8-572c5318ff37&action=ADDREPLICA&collection=testasynccollectioncreation&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 929088 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=758c7f62-4fb9-4491-82e8-572c5318ff37&action=ADDREPLICA&collection=testasynccollectioncreation&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=14 [junit4] 2> 929089 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 929091 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 929092 INFO (OverseerCollectionConfigSetProcessor-72316688244736006-127.0.0.1:46256_solr-n_0000000000) [n:127.0.0.1:46256_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000001 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 929114 INFO (OverseerThreadFactory-2241-thread-3-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:46256_solr for creating new replica [junit4] 2> 929126 INFO (OverseerStateUpdate-72316688244736006-127.0.0.1:46256_solr-n_0000000000) [n:127.0.0.1:46256_solr ] o.a.s.c.o.SliceMutator createReplica() { [junit4] 2> "operation":"addreplica", [junit4] 2> "collection":"testasynccollectioncreation", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testasynccollectioncreation_shard1_replica_n3", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:46256/solr";, [junit4] 2> "node_name":"127.0.0.1:46256_solr", [junit4] 2> "type":"NRT"} [junit4] 2> 929128 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929128 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929253 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={async=758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921&qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf1&name=testasynccollectioncreation_shard1_replica_n3&action=CREATE&collection=testasynccollectioncreation&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=0 [junit4] 2> 929253 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CoreAdminOperation core create command async=758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921&qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf1&name=testasynccollectioncreation_shard1_replica_n3&action=CREATE&collection=testasynccollectioncreation&shard=shard1&wt=javabin&version=2&replicaType=NRT [junit4] 2> 929253 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 929253 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 [junit4] 2> 929254 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 929305 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0 [junit4] 2> 929324 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.s.IndexSchema [testasynccollectioncreation_shard1_replica_n3] Schema name=minimal [junit4] 2> 929327 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 929327 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.CoreContainer Creating SolrCore 'testasynccollectioncreation_shard1_replica_n3' using configuration from collection testasynccollectioncreation, trusted=true [junit4] 2> 929327 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_46256.solr.core.testasynccollectioncreation.shard1.replica_n3' (registry 'solr.core.testasynccollectioncreation.shard1.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@1443b553 [junit4] 2> 929335 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.SolrCore solr.RecoveryStrategy.Builder [junit4] 2> 929336 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.SolrCore [[testasynccollectioncreation_shard1_replica_n3] ] Opening new SolrCore at [/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node1/testasynccollectioncreation_shard1_replica_n3], dataDir=[/home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.api.collections.CollectionsAPIAsyncDistributedZkTest_9E72F6703758B7F3-001/tempDir-001/node1/./testasynccollectioncreation_shard1_replica_n3/data/] [junit4] 2> 929389 INFO (zkCallback-1081-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929389 INFO (zkCallback-1081-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929389 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929389 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929441 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 929449 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 929543 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 929543 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 929544 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.s.SolrIndexSearcher Opening [Searcher@4778d880[testasynccollectioncreation_shard1_replica_n3] main] [junit4] 2> 929545 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 929546 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 929546 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 929547 INFO (searcherExecutor-2251-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.SolrCore [testasynccollectioncreation_shard1_replica_n3] Registered new searcher Searcher@4778d880[testasynccollectioncreation_shard1_replica_n3] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 929547 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1595530096412721152 [junit4] 2> 929550 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testasynccollectioncreation/terms/shard1 to Terms{values={core_node2=0, core_node4=0}, version=1} [junit4] 2> 929560 INFO (parallelCoreAdminExecutor-2242-thread-1-processing-n:127.0.0.1:46256_solr 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.ZkController Core needs to recover:testasynccollectioncreation_shard1_replica_n3 [junit4] 2> 929560 INFO (updateExecutor-1072-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.DefaultSolrCoreState Running recovery [junit4] 2> 929561 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true [junit4] 2> 929587 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy ###### startupVersions=[[]] [junit4] 2> 929633 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.S.Request [testasynccollectioncreation_shard1_replica_n1] webapp=/solr path=/admin/ping params={wt=javabin&version=2} hits=0 status=0 QTime=0 [junit4] 2> 929633 INFO (qtp1271735560-4270) [n:127.0.0.1:39783_solr c:testasynccollectioncreation s:shard1 r:core_node2 x:testasynccollectioncreation_shard1_replica_n1] o.a.s.c.S.Request [testasynccollectioncreation_shard1_replica_n1] webapp=/solr path=/admin/ping params={wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 929633 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy Begin buffering updates. core=[testasynccollectioncreation_shard1_replica_n3] [junit4] 2> 929633 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4] 2> 929633 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy Publishing state of core [testasynccollectioncreation_shard1_replica_n3] as recovering, leader is [http://127.0.0.1:39783/solr/testasynccollectioncreation_shard1_replica_n1/] and I am [http://127.0.0.1:46256/solr/testasynccollectioncreation_shard1_replica_n3/] [junit4] 2> 929636 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.ZkShardTerms Successful update of terms at /collections/testasynccollectioncreation/terms/shard1 to Terms{values={core_node2=0, core_node4_recovering=0, core_node4=0}, version=2} [junit4] 2> 929658 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy Sending prep recovery command to [http://127.0.0.1:39783/solr]; [WaitForState: action=PREPRECOVERY&core=testasynccollectioncreation_shard1_replica_n1&nodeName=127.0.0.1:46256_solr&coreNodeName=core_node4&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true] [junit4] 2> 929658 INFO (qtp1271735560-4274) [n:127.0.0.1:39783_solr ] o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node4, state: recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true, maxTime: 183 s [junit4] 2> 929669 INFO (qtp1271735560-4274) [n:127.0.0.1:39783_solr ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=testasynccollectioncreation, shard=shard1, thisCore=testasynccollectioncreation_shard1_replica_n1, leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, currentState=down, localState=active, nodeName=127.0.0.1:46256_solr, coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: core_node4:{"core":"testasynccollectioncreation_shard1_replica_n3","base_url":"http://127.0.0.1:46256/solr","node_name":"127.0.0.1:46256_solr","state":"down","type":"NRT"} [junit4] 2> 929758 INFO (zkCallback-1081-thread-2-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929758 INFO (zkCallback-1079-thread-1-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929758 INFO (zkCallback-1079-thread-2-processing-n:127.0.0.1:39783_solr) [n:127.0.0.1:39783_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 929758 INFO (zkCallback-1081-thread-1-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/testasynccollectioncreation/state.json] for collection [testasynccollectioncreation] has occurred - updating... (live nodes size: [2]) [junit4] 2> 930092 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 930092 INFO (qtp1254131660-4264) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 930255 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CoreAdminOperation Checking request status for : 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 [junit4] 2> 930255 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&requestid=758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 930257 INFO (OverseerThreadFactory-2241-thread-3-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 930679 INFO (qtp1271735560-4274) [n:127.0.0.1:39783_solr ] o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=testasynccollectioncreation, shard=shard1, thisCore=testasynccollectioncreation_shard1_replica_n1, leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true, currentState=recovering, localState=active, nodeName=127.0.0.1:46256_solr, coreNodeName=core_node4, onlyIfActiveCheckResult=false, nodeProps: core_node4:{"core":"testasynccollectioncreation_shard1_replica_n3","base_url":"http://127.0.0.1:46256/solr","node_name":"127.0.0.1:46256_solr","state":"recovering","type":"NRT"} [junit4] 2> 930679 INFO (qtp1271735560-4274) [n:127.0.0.1:39783_solr ] o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node4, state: recovering, checkLive: true, onlyIfLeader: true for: 1 seconds. [junit4] 2> 930679 INFO (qtp1271735560-4274) [n:127.0.0.1:39783_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={nodeName=127.0.0.1:46256_solr&onlyIfLeaderActive=true&core=testasynccollectioncreation_shard1_replica_n1&coreNodeName=core_node4&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2} status=0 QTime=1020 [junit4] 2> 931093 INFO (OverseerCollectionConfigSetProcessor-72316688244736006-127.0.0.1:46256_solr-n_0000000000) [n:127.0.0.1:46256_solr ] o.a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 931094 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931095 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 931095 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :deletestatus with params requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=DELETESTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931096 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=758c7f62-4fb9-4491-82e8-572c5318ff37&action=DELETESTATUS&wt=javabin&version=2} status=0 QTime=0 [junit4] 2> 931096 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :splitshard with params async=71881539-e10e-490f-a3be-632c153430af&action=SPLITSHARD&collection=testasynccollectioncreation&shard=shard1&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931098 INFO (qtp1254131660-4266) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={async=71881539-e10e-490f-a3be-632c153430af&action=SPLITSHARD&collection=testasynccollectioncreation&shard=shard1&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 931099 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :requeststatus with params requestid=71881539-e10e-490f-a3be-632c153430af&action=REQUESTSTATUS&wt=javabin&version=2 and sendToOCPQueue=true [junit4] 2> 931100 INFO (qtp1254131660-4261) [n:127.0.0.1:46256_solr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={requestid=71881539-e10e-490f-a3be-632c153430af&action=REQUESTSTATUS&wt=javabin&version=2} status=0 QTime=1 [junit4] 2> 931100 INFO (OverseerThreadFactory-2241-thread-4-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.SplitShardCmd Split shard invoked [junit4] 2> 931133 INFO (OverseerThreadFactory-2241-thread-4-processing-n:127.0.0.1:46256_solr) [n:127.0.0.1:46256_solr ] o.a.s.c.a.c.SplitShardCmd Creating slice shard1_0 of collection testasynccollectioncreation on 127.0.0.1:39783_solr [junit4] 2> 931183 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_shard1_replica_n3] o.a.s.c.RecoveryStrategy Attempting to PeerSync from [http://127.0.0.1:39783/solr/testasynccollectioncreation_shard1_replica_n1/] - recoveringAfterStartup=[true] [junit4] 2> 931184 INFO (recoveryExecutor-1074-thread-1-processing-x:testasynccollectioncreation_shard1_replica_n3 r:core_node4 758c7f62-4fb9-4491-82e8-572c5318ff373953474620184921 CREATE n:127.0.0.1:46256_solr s:shard1 c:testasynccollectioncreation) [n:127.0.0.1:46256_solr c:testasynccollectioncreation s:shard1 r:core_node4 x:testasynccollectioncreation_sh [...truncated too long message...] ngeQuery, TestFieldTypeCollectionResource, CachingDirectoryFactoryTest, TestLazyCores, TestBulkSchemaAPI, TestSolr4Spatial2, ClusterStateTest, TestSolrCLIRunExample, TestRetrieveFieldsOptimizer, TestFastWriter, TestMacros, TestFieldCache, OverseerStatusTest, RecoveryZkTest, AddReplicaTest, TestPullReplica, TestSchemalessBufferedUpdates, TestSubQueryTransformer, TestLRUStatsCache, RegexBytesRefFilterTest, TestCloudDeleteByQuery, CacheHeaderTest, URLClassifyProcessorTest, TestCodecSupport, TestSSLRandomization, SolrCmdDistributorTest, TestUseDocValuesAsStored2, CreateCollectionCleanupTest, DeleteShardTest, TestFieldCacheSortRandom, TestHdfsUpdateLog, DateMathParserTest, MetricUtilsTest, TestDownShardTolerantSearch, NodeLostTriggerTest, DateRangeFieldTest, TestClassicSimilarityFactory, TestCloudManagedSchema, TestLMJelinekMercerSimilarityFactory, HdfsRestartWhileUpdatingTest, HttpPartitionOnCommitTest, TestTolerantSearch, TestMissingGroups, MetricsConfigTest, TestValueSourceCache, LeaderElectionIntegrationTest, SpellPossibilityIteratorTest, SharedFSAutoReplicaFailoverTest, BasicDistributedZk2Test, ConvertedLegacyTest, TestRandomDVFaceting, LIRRollingUpdatesTest, TestMaxTokenLenTokenizer, DirectoryFactoryTest, TestNumericTokenStream, SearchRateTriggerTest, TestLargeCluster, SearchHandlerTest, MoreLikeThisHandlerTest, TestSearcherReuse, TestRuleBasedAuthorizationPlugin, HdfsDirectoryTest, RegexBoostProcessorTest, TestQueryWrapperFilter, DistributedSpellCheckComponentTest, ComputePlanActionTest] [junit4] Completed [336/784 (2!)] on J2 in 37.49s, 4 tests, 1 error, 1 skipped <<< FAILURES! [...truncated 4593 lines...] [junit4] Suite: org.apache.solr.analytics.facet.ValueFacetTest [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/contrib/solr-analytics/test/J0/temp/solr.analytics.facet.ValueFacetTest_A3EB4FF7DD019AFA-001/init-core-data-001 [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ValueFacetTest -Dtests.method=meanTest -Dtests.seed=A3EB4FF7DD019AFA -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=sq -Dtests.timezone=IET -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 30.7s J0 | ValueFacetTest.meanTest <<< [junit4] > Throwable #1: java.lang.RuntimeException: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] [junit4] > at __randomizedtesting.SeedInfo.seed([A3EB4FF7DD019AFA:A96D9F52E3F31585]:0) [junit4] > at org.apache.solr.analytics.facet.SolrAnalyticsFacetTestCase.testGrouping(SolrAnalyticsFacetTestCase.java:77) [junit4] > at org.apache.solr.analytics.facet.ValueFacetTest.meanTest(ValueFacetTest.java:338) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.queryCloudObject(SolrAnalyticsTestCase.java:147) [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.testResults(SolrAnalyticsTestCase.java:98) [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.testAnalytics(SolrAnalyticsTestCase.java:162) [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.testGroupingSorted(SolrAnalyticsTestCase.java:260) [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.testGrouping(SolrAnalyticsTestCase.java:205) [junit4] > at org.apache.solr.analytics.facet.SolrAnalyticsFacetTestCase.testGrouping(SolrAnalyticsFacetTestCase.java:75) [junit4] > ... 40 more [junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: No live SolrServers available to handle this request:[http://127.0.0.1:37327/solr/collection1, http://127.0.0.1:44040/solr/collection1] [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:462) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1105) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:885) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:818) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) [junit4] > at org.apache.solr.analytics.SolrAnalyticsTestCase.queryCloudObject(SolrAnalyticsTestCase.java:145) [junit4] > ... 45 more [junit4] > Caused by: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:37327/solr/collection1: java.lang.IndexOutOfBoundsException: Index: 0, Size: 0 [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) [junit4] > ... 50 more [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/contrib/solr-analytics/test/J0/temp/solr.analytics.facet.ValueFacetTest_A3EB4FF7DD019AFA-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {string_s=FST50, id=PostingsFormat(name=Memory), string_sm=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128)))}, docValues:{int_i=DocValuesFormat(name=Direct), double_dm=DocValuesFormat(name=Lucene70), float_fm=DocValuesFormat(name=Lucene70), int_im=DocValuesFormat(name=Lucene70), date_dt=DocValuesFormat(name=Direct), date_dtm=DocValuesFormat(name=Asserting), long_lm=DocValuesFormat(name=Asserting), double_d=DocValuesFormat(name=Lucene70), float_f=DocValuesFormat(name=Lucene70), long_l=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Asserting), string_s=DocValuesFormat(name=Direct), id=DocValuesFormat(name=Lucene70), string_sm=DocValuesFormat(name=Lucene70)}, maxPointsInLeafNode=898, maxMBSortInHeap=7.833226673776336, sim=RandomSimilarity(queryNorm=true): {}, locale=sq, timezone=IET [junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=4,threads=1,free=91724488,total=270008320 [junit4] 2> NOTE: All tests run in this JVM: [DateMathFunctionTest, ValueFacetTest] [junit4] Completed [12/78 (1!)] on J0 in 109.58s, 11 tests, 1 error <<< FAILURES! [...truncated 127 lines...] [junit4] Suite: org.apache.solr.analytics.legacy.facet.LegacyFieldFacetCloudTest [junit4] 2> Creating dataDir: /home/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/contrib/solr-analytics/test/J0/temp/solr.analytics.legacy.facet.LegacyFieldFacetCloudTest_A3EB4FF7DD019AFA-001/init-core-data-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=574, maxMBSortInHeap=6.255004514079946, sim=RandomSimilarity(queryNorm=false): {}, locale=en-ZA, timezone=IST [junit4] 2> NOTE: Linux 4.4.0-112-generic amd64/Oracle Corporation 1.8.0_152 (64-bit)/cpus=4,threads=1,free=160533648,total=275251200 [junit4] 2> NOTE: All tests run in this JVM: [DateMathFunctionTest, ValueFacetTest, NegateFunctionTest, LegacyAbstractAnalyticsCloudTest, RemoveFunctionTest, LegacyFieldFacetTest, FilterFunctionTest, ExpressionFactoryTest, DateFieldsTest, StringCastFunctionTest, PivotFacetTest, LegacyNoFacetTest, LegacyFieldFacetCloudTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=LegacyFieldFacetCloudTest -Dtests.seed=A3EB4FF7DD019AFA -Dtests.multiplier=2 -Dtests.slow=true -Dtests.locale=en-ZA -Dtests.timezone=IST -Dtests.asserts=true -Dtests.file.encoding=UTF-8 [junit4] ERROR 0.00s J0 | LegacyFieldFacetCloudTest (suite) <<< [junit4] > Throwable #1: org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error from server at http://127.0.0.1:43691/solr: KeeperErrorCode = Session expired for /configs/conf [junit4] > at __randomizedtesting.SeedInfo.seed([A3EB4FF7DD019AFA]:0) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:643) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:255) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:244) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483) [junit4] > at org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1105) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:885) [junit4] > at org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:818) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194) [junit4] > at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:211) [junit4] > at org.apache.solr.analytics.legacy.LegacyAbstractAnalyticsCloudTest.setupCollection(LegacyAbstractAnalyticsCloudTest.java:50) [junit4] > at java.lang.Thread.run(Thread.java:748) [junit4] Completed [58/78 (2!)] on J0 in 27.54s, 0 tests, 1 error <<< FAILURES! [...truncated 46411 lines...]
--------------------------------------------------------------------- To unsubscribe, e-mail: [email protected] For additional commands, e-mail: [email protected]
