Build: https://builds.apache.org/job/Lucene-Solr-Tests-7.x/600/
4 tests failed.
FAILED: org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaFromClusterState
Error Message:
Collection not found: deleteFromClusterState_false
Stack Trace:
org.apache.solr.common.SolrException: Collection not found:
deleteFromClusterState_false
at
__randomizedtesting.SeedInfo.seed([4B4137FF3E44AD3F:A5D89C92017AD688]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:853)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:819)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:194)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:173)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:138)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaFromClusterState(DeleteReplicaTest.java:187)
at
org.apache.solr.cloud.DeleteReplicaTest.deleteReplicaFromClusterState(DeleteReplicaTest.java:178)
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)
FAILED: junit.framework.TestSuite.org.apache.solr.cloud.ZkControllerTest
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [Overseer]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException:
org.apache.solr.cloud.Overseer at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.cloud.Overseer.start(Overseer.java:545) at
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:851)
at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
at org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307) at
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393) at
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2081)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not
released!!! [Overseer]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException:
org.apache.solr.cloud.Overseer
at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:42)
at org.apache.solr.cloud.Overseer.start(Overseer.java:545)
at
org.apache.solr.cloud.OverseerElectionContext.runLeaderProcess(ElectionContext.java:851)
at
org.apache.solr.cloud.LeaderElector.runIamLeaderProcess(LeaderElector.java:170)
at
org.apache.solr.cloud.LeaderElector.checkIfIamLeader(LeaderElector.java:135)
at
org.apache.solr.cloud.LeaderElector.joinElection(LeaderElector.java:307)
at
org.apache.solr.cloud.LeaderElector.retryElection(LeaderElector.java:393)
at
org.apache.solr.cloud.ZkController.rejoinOverseerElection(ZkController.java:2081)
at
org.apache.solr.cloud.Overseer$ClusterStateUpdater.checkIfIamStillLeader(Overseer.java:331)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([4B4137FF3E44AD3F]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:303)
at sun.reflect.GeneratedMethodAccessor38.invoke(Unknown Source)
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$7.evaluate(RandomizedRunner.java:897)
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: junit.framework.TestSuite.org.apache.solr.cloud.ZkControllerTest
Error Message:
1 thread leaked from SUITE scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=11090,
name=OverseerAutoScalingTriggerThread-73766542553120771-127.0.0.1:8983_solr-n_0000000001,
state=RUNNABLE, group=Overseer autoscaling triggers] at
java.lang.ClassLoader.findLoadedClass0(Native Method) at
java.lang.ClassLoader.findLoadedClass(ClassLoader.java:1038) at
java.lang.ClassLoader.loadClass(ClassLoader.java:406) at
sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:349) at
java.lang.ClassLoader.loadClass(ClassLoader.java:357) at
org.apache.logging.log4j.core.impl.ThrowableProxy.loadClass(ThrowableProxy.java:613)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.toExtendedStackTrace(ThrowableProxy.java:738)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:164)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:141)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:122)
at
org.apache.logging.log4j.core.impl.Log4jLogEvent.getThrownProxy(Log4jLogEvent.java:605)
at
org.apache.logging.log4j.core.pattern.ExtendedThrowablePatternConverter.format(ExtendedThrowablePatternConverter.java:64)
at
org.apache.logging.log4j.core.pattern.PatternFormatter.format(PatternFormatter.java:38)
at
org.apache.logging.log4j.core.layout.PatternLayout$PatternSerializer.toSerializable(PatternLayout.java:334)
at
org.apache.logging.log4j.core.layout.PatternLayout.toText(PatternLayout.java:233)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:218)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:58)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.directEncodeEvent(AbstractOutputStreamAppender.java:177)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.tryAppend(AbstractOutputStreamAppender.java:170)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.append(AbstractOutputStreamAppender.java:161)
at
org.apache.logging.log4j.core.config.AppenderControl.tryCallAppender(AppenderControl.java:156)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender0(AppenderControl.java:129)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppenderPreventRecursion(AppenderControl.java:120)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender(AppenderControl.java:84)
at
org.apache.logging.log4j.core.config.LoggerConfig.callAppenders(LoggerConfig.java:448)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:433)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:403)
at
org.apache.logging.log4j.core.config.DefaultReliabilityStrategy.log(DefaultReliabilityStrategy.java:49)
at org.apache.logging.log4j.core.Logger.logMessage(Logger.java:146)
at
org.apache.logging.log4j.spi.AbstractLogger.tryLogMessage(AbstractLogger.java:2170)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageTrackRecursion(AbstractLogger.java:2125)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageSafely(AbstractLogger.java:2108)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessage(AbstractLogger.java:2002)
at
org.apache.logging.log4j.spi.AbstractLogger.logIfEnabled(AbstractLogger.java:1974)
at org.apache.logging.slf4j.Log4jLogger.error(Log4jLogger.java:319)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:146)
at java.lang.Thread.run(Thread.java:748)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.ZkControllerTest:
1) Thread[id=11090,
name=OverseerAutoScalingTriggerThread-73766542553120771-127.0.0.1:8983_solr-n_0000000001,
state=RUNNABLE, group=Overseer autoscaling triggers]
at java.lang.ClassLoader.findLoadedClass0(Native Method)
at java.lang.ClassLoader.findLoadedClass(ClassLoader.java:1038)
at java.lang.ClassLoader.loadClass(ClassLoader.java:406)
at sun.misc.Launcher$AppClassLoader.loadClass(Launcher.java:349)
at java.lang.ClassLoader.loadClass(ClassLoader.java:357)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.loadClass(ThrowableProxy.java:613)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.toExtendedStackTrace(ThrowableProxy.java:738)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:164)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:141)
at
org.apache.logging.log4j.core.impl.ThrowableProxy.<init>(ThrowableProxy.java:122)
at
org.apache.logging.log4j.core.impl.Log4jLogEvent.getThrownProxy(Log4jLogEvent.java:605)
at
org.apache.logging.log4j.core.pattern.ExtendedThrowablePatternConverter.format(ExtendedThrowablePatternConverter.java:64)
at
org.apache.logging.log4j.core.pattern.PatternFormatter.format(PatternFormatter.java:38)
at
org.apache.logging.log4j.core.layout.PatternLayout$PatternSerializer.toSerializable(PatternLayout.java:334)
at
org.apache.logging.log4j.core.layout.PatternLayout.toText(PatternLayout.java:233)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:218)
at
org.apache.logging.log4j.core.layout.PatternLayout.encode(PatternLayout.java:58)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.directEncodeEvent(AbstractOutputStreamAppender.java:177)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.tryAppend(AbstractOutputStreamAppender.java:170)
at
org.apache.logging.log4j.core.appender.AbstractOutputStreamAppender.append(AbstractOutputStreamAppender.java:161)
at
org.apache.logging.log4j.core.config.AppenderControl.tryCallAppender(AppenderControl.java:156)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender0(AppenderControl.java:129)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppenderPreventRecursion(AppenderControl.java:120)
at
org.apache.logging.log4j.core.config.AppenderControl.callAppender(AppenderControl.java:84)
at
org.apache.logging.log4j.core.config.LoggerConfig.callAppenders(LoggerConfig.java:448)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:433)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.logParent(LoggerConfig.java:439)
at
org.apache.logging.log4j.core.config.LoggerConfig.processLogEvent(LoggerConfig.java:434)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:417)
at
org.apache.logging.log4j.core.config.LoggerConfig.log(LoggerConfig.java:403)
at
org.apache.logging.log4j.core.config.DefaultReliabilityStrategy.log(DefaultReliabilityStrategy.java:49)
at org.apache.logging.log4j.core.Logger.logMessage(Logger.java:146)
at
org.apache.logging.log4j.spi.AbstractLogger.tryLogMessage(AbstractLogger.java:2170)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageTrackRecursion(AbstractLogger.java:2125)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessageSafely(AbstractLogger.java:2108)
at
org.apache.logging.log4j.spi.AbstractLogger.logMessage(AbstractLogger.java:2002)
at
org.apache.logging.log4j.spi.AbstractLogger.logIfEnabled(AbstractLogger.java:1974)
at org.apache.logging.slf4j.Log4jLogger.error(Log4jLogger.java:319)
at
org.apache.solr.cloud.autoscaling.OverseerTriggerThread.run(OverseerTriggerThread.java:146)
at java.lang.Thread.run(Thread.java:748)
at __randomizedtesting.SeedInfo.seed([4B4137FF3E44AD3F]:0)
FAILED:
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration
Error Message:
last state:
DocCollection(testSplitIntegration_collection//clusterstate.json/57)={
"replicationFactor":"2", "pullReplicas":"0",
"router":{"name":"compositeId"}, "maxShardsPerNode":"2",
"autoAddReplicas":"false", "nrtReplicas":"2", "tlogReplicas":"0",
"autoCreated":"true", "shards":{ "shard2":{ "replicas":{
"core_node3":{
"core":"testSplitIntegration_collection_shard2_replica_n3",
"leader":"true", "SEARCHER.searcher.maxDoc":11,
"SEARCHER.searcher.deletedDocs":0, "INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":11}, "core_node4":{
"core":"testSplitIntegration_collection_shard2_replica_n4",
"SEARCHER.searcher.maxDoc":11, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10000_solr",
"state":"active", "type":"NRT",
"SEARCHER.searcher.numDocs":11}}, "range":"0-7fffffff",
"state":"active"}, "shard1":{ "stateTimestamp":"1525826290547188800",
"replicas":{ "core_node1":{
"core":"testSplitIntegration_collection_shard1_replica_n1",
"leader":"true", "SEARCHER.searcher.maxDoc":14,
"SEARCHER.searcher.deletedDocs":0, "INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":14}, "core_node2":{
"core":"testSplitIntegration_collection_shard1_replica_n2",
"SEARCHER.searcher.maxDoc":14, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10000_solr",
"state":"active", "type":"NRT",
"SEARCHER.searcher.numDocs":14}}, "range":"80000000-ffffffff",
"state":"inactive"}, "shard1_1":{ "parent":"shard1",
"stateTimestamp":"1525826290581584850", "range":"c0000000-ffffffff",
"state":"active", "replicas":{ "core_node10":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_1_replica1",
"SEARCHER.searcher.maxDoc":6, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10000_solr",
"base_url":"http://127.0.0.1:10000/solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":6},
"core_node9":{
"core":"testSplitIntegration_collection_shard1_1_replica0",
"SEARCHER.searcher.maxDoc":6, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10001_solr",
"base_url":"http://127.0.0.1:10001/solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":6}}}, "shard1_0":{
"parent":"shard1", "stateTimestamp":"1525826290581230050",
"range":"80000000-bfffffff", "state":"active", "replicas":{
"core_node7":{ "leader":"true",
"core":"testSplitIntegration_collection_shard1_0_replica0",
"SEARCHER.searcher.maxDoc":7, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10001_solr",
"base_url":"http://127.0.0.1:10001/solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":7},
"core_node8":{
"core":"testSplitIntegration_collection_shard1_0_replica1",
"SEARCHER.searcher.maxDoc":7, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1, "node_name":"127.0.0.1:10000_solr",
"base_url":"http://127.0.0.1:10000/solr", "state":"active",
"type":"NRT", "SEARCHER.searcher.numDocs":7}}}}}
Stack Trace:
java.util.concurrent.TimeoutException: last state:
DocCollection(testSplitIntegration_collection//clusterstate.json/57)={
"replicationFactor":"2",
"pullReplicas":"0",
"router":{"name":"compositeId"},
"maxShardsPerNode":"2",
"autoAddReplicas":"false",
"nrtReplicas":"2",
"tlogReplicas":"0",
"autoCreated":"true",
"shards":{
"shard2":{
"replicas":{
"core_node3":{
"core":"testSplitIntegration_collection_shard2_replica_n3",
"leader":"true",
"SEARCHER.searcher.maxDoc":11,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":11},
"core_node4":{
"core":"testSplitIntegration_collection_shard2_replica_n4",
"SEARCHER.searcher.maxDoc":11,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10000_solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":11}},
"range":"0-7fffffff",
"state":"active"},
"shard1":{
"stateTimestamp":"1525826290547188800",
"replicas":{
"core_node1":{
"core":"testSplitIntegration_collection_shard1_replica_n1",
"leader":"true",
"SEARCHER.searcher.maxDoc":14,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":14},
"core_node2":{
"core":"testSplitIntegration_collection_shard1_replica_n2",
"SEARCHER.searcher.maxDoc":14,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10000_solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":14}},
"range":"80000000-ffffffff",
"state":"inactive"},
"shard1_1":{
"parent":"shard1",
"stateTimestamp":"1525826290581584850",
"range":"c0000000-ffffffff",
"state":"active",
"replicas":{
"core_node10":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_1_replica1",
"SEARCHER.searcher.maxDoc":6,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10000_solr",
"base_url":"http://127.0.0.1:10000/solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":6},
"core_node9":{
"core":"testSplitIntegration_collection_shard1_1_replica0",
"SEARCHER.searcher.maxDoc":6,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr",
"base_url":"http://127.0.0.1:10001/solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":6}}},
"shard1_0":{
"parent":"shard1",
"stateTimestamp":"1525826290581230050",
"range":"80000000-bfffffff",
"state":"active",
"replicas":{
"core_node7":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_0_replica0",
"SEARCHER.searcher.maxDoc":7,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10001_solr",
"base_url":"http://127.0.0.1:10001/solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":7},
"core_node8":{
"core":"testSplitIntegration_collection_shard1_0_replica1",
"SEARCHER.searcher.maxDoc":7,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":1,
"node_name":"127.0.0.1:10000_solr",
"base_url":"http://127.0.0.1:10000/solr",
"state":"active",
"type":"NRT",
"SEARCHER.searcher.numDocs":7}}}}}
at
__randomizedtesting.SeedInfo.seed([4B4137FF3E44AD3F:72CF8EBF11BB64C1]:0)
at
org.apache.solr.cloud.CloudTestUtils.waitForState(CloudTestUtils.java:111)
at
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration(IndexSizeTriggerTest.java:299)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 12832 lines...]
[junit4] Suite: org.apache.solr.cloud.DeleteReplicaTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/init-core-data-001
[junit4] 2> 358599 WARN
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
[junit4] 2> 358599 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 358601 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 358602 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 358602 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001
[junit4] 2> 358602 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 358613 INFO (Thread-353) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 358613 INFO (Thread-353) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 358645 ERROR (Thread-353) [ ] 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> 358713 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:42585
[junit4] 2> 358775 INFO (zkConnectionManagerCallback-2984-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 358795 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 358825 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 358830 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 358840 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 2017-11-21T21:27:37Z,
git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 358892 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 358892 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 358892 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 358893 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@c420122{/solr,null,AVAILABLE}
[junit4] 2> 358896 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@44278e38{SSL,[ssl,
http/1.1]}{127.0.0.1:37714}
[junit4] 2> 358896 INFO (jetty-launcher-2981-thread-1) [ ]
o.e.j.s.Server Started @359030ms
[junit4] 2> 358896 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37714}
[junit4] 2> 358897 ERROR (jetty-launcher-2981-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 358897 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 358897 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 358897 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 358897 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 358897 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T23:45:48.340Z
[junit4] 2> 358940 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 358940 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 358940 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 358941 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1e4ff628{/solr,null,AVAILABLE}
[junit4] 2> 358941 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@32ba3914{SSL,[ssl,
http/1.1]}{127.0.0.1:39142}
[junit4] 2> 358941 INFO (jetty-launcher-2981-thread-3) [ ]
o.e.j.s.Server Started @359075ms
[junit4] 2> 358941 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39142}
[junit4] 2> 358942 ERROR (jetty-launcher-2981-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 358942 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 358942 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 358942 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 358942 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 358942 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T23:45:48.385Z
[junit4] 2> 358981 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 358981 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 358981 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.session Scavenging every 660000ms
[junit4] 2> 358992 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@66d722c2{/solr,null,AVAILABLE}
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@43556c6d{SSL,[ssl,
http/1.1]}{127.0.0.1:40123}
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.e.j.s.Server Started @359127ms
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=40123}
[junit4] 2> 358993 ERROR (jetty-launcher-2981-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 358993 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T23:45:48.436Z
[junit4] 2> 359036 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 359036 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 359036 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 359048 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@36596210{/solr,null,AVAILABLE}
[junit4] 2> 359049 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5b8ca593{SSL,[ssl,
http/1.1]}{127.0.0.1:49027}
[junit4] 2> 359049 INFO (jetty-launcher-2981-thread-4) [ ]
o.e.j.s.Server Started @359183ms
[junit4] 2> 359049 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49027}
[junit4] 2> 359049 ERROR (jetty-launcher-2981-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 359049 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 359049 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.4.0
[junit4] 2> 359050 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 359050 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 359050 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T23:45:48.493Z
[junit4] 2> 359076 INFO (zkConnectionManagerCallback-2986-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359076 INFO (zkConnectionManagerCallback-2990-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359077 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 359083 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 359096 INFO (zkConnectionManagerCallback-2988-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359096 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 359109 INFO (zkConnectionManagerCallback-2992-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359110 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 359128 INFO (jetty-launcher-2981-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42585/solr
[junit4] 2> 359166 INFO (jetty-launcher-2981-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42585/solr
[junit4] 2> 359180 INFO (zkConnectionManagerCallback-2996-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359207 INFO (jetty-launcher-2981-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42585/solr
[junit4] 2> 359227 INFO (zkConnectionManagerCallback-3001-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359235 INFO (jetty-launcher-2981-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42585/solr
[junit4] 2> 359276 INFO (zkConnectionManagerCallback-3010-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359281 INFO (zkConnectionManagerCallback-3005-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359300 INFO (zkConnectionManagerCallback-3007-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359300 INFO (zkConnectionManagerCallback-3012-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359407 INFO (zkConnectionManagerCallback-3016-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359434 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 359435 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:49027_solr
[junit4] 2> 359413 INFO (zkConnectionManagerCallback-3014-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359436 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.Overseer Overseer
(id=73766448193798155-127.0.0.1:49027_solr-n_0000000000) starting
[junit4] 2> 359458 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 359460 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39142_solr
[junit4] 2> 359528 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 359545 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 359549 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 359549 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40123_solr
[junit4] 2> 359550 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 359569 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 359571 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 359571 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37714_solr
[junit4] 2> 359572 INFO (zkConnectionManagerCallback-3029-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 359581 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 359582 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:42585/solr ready
[junit4] 2> 359620 INFO (zkCallback-3013-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 359621 INFO (zkCallback-3015-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 359635 INFO
(OverseerStateUpdate-73766448193798155-127.0.0.1:49027_solr-n_0000000000) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 359665 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 359665 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49027_solr
[junit4] 2> 359692 INFO (zkCallback-3013-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (4)
[junit4] 2> 359696 INFO (zkCallback-3015-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 359714 INFO (zkCallback-3011-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
[junit4] 2> 359714 INFO (zkCallback-3006-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (4)
[junit4] 2> 359758 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 359800 INFO (zkCallback-3028-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 359862 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39142.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 359985 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39142.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 359992 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39142.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 359993 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node3/.
[junit4] 2> 360092 INFO (zkConnectionManagerCallback-3034-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360093 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 360094 INFO (jetty-launcher-2981-thread-3)
[n:127.0.0.1:39142_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:42585/solr ready
[junit4] 2> 360194 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360237 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360237 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360240 INFO (jetty-launcher-2981-thread-4)
[n:127.0.0.1:49027_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node4/.
[junit4] 2> 360357 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37714.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360369 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37714.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360369 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37714.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360371 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node1/.
[junit4] 2> 360498 INFO (zkConnectionManagerCallback-3039-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360503 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 360504 INFO (jetty-launcher-2981-thread-1)
[n:127.0.0.1:37714_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:42585/solr ready
[junit4] 2> 360666 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40123.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360677 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40123.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360678 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40123.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 360679 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node2/.
[junit4] 2> 360683 INFO (zkConnectionManagerCallback-3044-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360684 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 360685 INFO (jetty-launcher-2981-thread-2)
[n:127.0.0.1:40123_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:42585/solr ready
[junit4] 2> 360740 INFO (zkConnectionManagerCallback-3046-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360747 INFO (zkConnectionManagerCallback-3051-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 360748 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 360749 INFO
(SUITE-DeleteReplicaTest-seed#[4B4137FF3E44AD3F]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42585/solr ready
[junit4] 2> 360797 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.SolrTestCaseJ4 ###Starting raceConditionOnDeleteAndRegisterReplica
[junit4] 2> 360829 INFO (qtp370863803-6374) [n:127.0.0.1:40123_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop with params
val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 360832 INFO (qtp370863803-6374) [n:127.0.0.1:40123_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={val=true&name=legacyCloud&action=CLUSTERPROP&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 360838 INFO (qtp370863803-6376) [n:127.0.0.1:40123_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&collection.configName=conf&name=raceDeleteReplica_true&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 360880 INFO (OverseerThreadFactory-1127-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection raceDeleteReplica_true
[junit4] 2> 361019 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
x:raceDeleteReplica_true_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=raceDeleteReplica_true_shard1_replica_n1&action=CREATE&numShards=1&collection=raceDeleteReplica_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 361059 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=raceDeleteReplica_true_shard1_replica_n2&action=CREATE&numShards=1&collection=raceDeleteReplica_true&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 362044 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 362066 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.s.IndexSchema [raceDeleteReplica_true_shard1_replica_n1] Schema
name=minimal
[junit4] 2> 362069 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 362069 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore
'raceDeleteReplica_true_shard1_replica_n1' using configuration from collection
raceDeleteReplica_true, trusted=true
[junit4] 2> 362070 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_40123.solr.core.raceDeleteReplica_true.shard1.replica_n1' (registry
'solr.core.raceDeleteReplica_true.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 362070 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 362071 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.SolrCore [[raceDeleteReplica_true_shard1_replica_n1] ] Opening new
SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node2/raceDeleteReplica_true_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node2/./raceDeleteReplica_true_shard1_replica_n1/data/]
[junit4] 2> 362074 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 362082 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.s.IndexSchema [raceDeleteReplica_true_shard1_replica_n2] Schema
name=minimal
[junit4] 2> 362085 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 362085 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.c.CoreContainer Creating SolrCore
'raceDeleteReplica_true_shard1_replica_n2' using configuration from collection
raceDeleteReplica_true, trusted=true
[junit4] 2> 362090 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.core.raceDeleteReplica_true.shard1.replica_n2' (registry
'solr.core.raceDeleteReplica_true.shard1.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 362090 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 362090 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.c.SolrCore [[raceDeleteReplica_true_shard1_replica_n2] ] Opening new
SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node4/raceDeleteReplica_true_shard1_replica_n2],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node4/./raceDeleteReplica_true_shard1_replica_n2/data/]
[junit4] 2> 362146 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 362146 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 362151 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 362151 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 362154 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@69132e03[raceDeleteReplica_true_shard1_replica_n1] main]
[junit4] 2> 362155 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 362156 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 362157 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 362157 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1599941537012121600
[junit4] 2> 362157 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 362157 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 362159 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 362159 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 362166 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@714ff51f[raceDeleteReplica_true_shard1_replica_n2] main]
[junit4] 2> 362166 INFO
(searcherExecutor-1136-thread-1-processing-n:127.0.0.1:40123_solr
x:raceDeleteReplica_true_shard1_replica_n1 c:raceDeleteReplica_true s:shard1)
[n:127.0.0.1:40123_solr c:raceDeleteReplica_true s:shard1
x:raceDeleteReplica_true_shard1_replica_n1] o.a.s.c.SolrCore
[raceDeleteReplica_true_shard1_replica_n1] Registered new searcher
Searcher@69132e03[raceDeleteReplica_true_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 362167 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 362170 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/raceDeleteReplica_true/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 362170 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 362171 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 362172 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1599941537027850240
[junit4] 2> 362176 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Waiting until we see more replicas up for
shard shard1: total=2 found=1 timeoutin=9999ms
[junit4] 2> 362176 INFO
(searcherExecutor-1137-thread-1-processing-n:127.0.0.1:49027_solr
x:raceDeleteReplica_true_shard1_replica_n2 c:raceDeleteReplica_true s:shard1)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.SolrCore
[raceDeleteReplica_true_shard1_replica_n2] Registered new searcher
Searcher@714ff51f[raceDeleteReplica_true_shard1_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 362180 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/raceDeleteReplica_true/terms/shard1 to Terms{values={core_node3=0,
core_node4=0}, version=1}
[junit4] 2> 362677 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 362677 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 362677 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:40123/solr/raceDeleteReplica_true_shard1_replica_n1/
[junit4] 2> 362678 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.PeerSync PeerSync: core=raceDeleteReplica_true_shard1_replica_n1
url=https://127.0.0.1:40123/solr START
replicas=[https://127.0.0.1:49027/solr/raceDeleteReplica_true_shard1_replica_n2/]
nUpdates=100
[junit4] 2> 362689 INFO (qtp647969196-6365) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.S.Request
[raceDeleteReplica_true_shard1_replica_n2] webapp=/solr path=/get
params={distrib=false&qt=/get&fingerprint=false&getVersions=100&wt=javabin&version=2}
status=0 QTime=2
[junit4] 2> 362978 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.u.PeerSync PeerSync: core=raceDeleteReplica_true_shard1_replica_n1
url=https://127.0.0.1:40123/solr DONE. We have no versions. sync failed.
[junit4] 2> 362978 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.SyncStrategy Leader's attempt to sync with shard failed, moving to the
next candidate
[junit4] 2> 362978 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext We failed sync, but we have no versions - we
can't sync in that case - we were active before, so become leader anyway
[junit4] 2> 362978 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 362983 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:40123/solr/raceDeleteReplica_true_shard1_replica_n1/ shard1
[junit4] 2> 363086 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 363090 INFO (qtp370863803-6380) [n:127.0.0.1:40123_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=raceDeleteReplica_true_shard1_replica_n1&action=CREATE&numShards=1&collection=raceDeleteReplica_true&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2070
[junit4] 2> 363188 INFO (qtp647969196-6386) [n:127.0.0.1:49027_solr
c:raceDeleteReplica_true s:shard1 x:raceDeleteReplica_true_shard1_replica_n2]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=raceDeleteReplica_true_shard1_replica_n2&action=CREATE&numShards=1&collection=raceDeleteReplica_true&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2129
[junit4] 2> 363194 INFO (qtp370863803-6376) [n:127.0.0.1:40123_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 363289 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/raceDeleteReplica_true/state.json] for collection
[raceDeleteReplica_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 363289 INFO (zkCallback-3015-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/raceDeleteReplica_true/state.json] for collection
[raceDeleteReplica_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 364195 INFO (qtp370863803-6376) [n:127.0.0.1:40123_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=2&collection.configName=conf&name=raceDeleteReplica_true&nrtReplicas=2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=3356
[junit4] 2> 364200 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.AbstractConnector Stopped ServerConnector@5b8ca593{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 364207 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=2095444177
[junit4] 2> 364207 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 364208 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@909f173: rootName =
solr_49027, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@6068f37d
[junit4] 2> 364216 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jvm, tag=null
[junit4] 2> 364216 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4dcc3305: rootName =
solr_49027, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@7ef3ffde
[junit4] 2> 364221 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.jetty, tag=null
[junit4] 2> 364223 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@35e8806: rootName =
solr_49027, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@6d8e2421
[junit4] 2> 364226 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.c.ZkController Remove node as live in
ZooKeeper:/live_nodes/127.0.0.1:49027_solr
[junit4] 2> 364233 INFO (zkCallback-3013-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3050-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3006-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3043-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3038-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364234 INFO (zkCallback-3033-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364235 INFO (zkCallback-3028-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364236 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.cluster, tag=null
[junit4] 2> 364238 INFO (zkCallback-3015-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 364239 INFO (coreCloseExecutor-1146-thread-1)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.SolrCore
[raceDeleteReplica_true_shard1_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@190887d9
[junit4] 2> 364239 INFO (coreCloseExecutor-1146-thread-1)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.core.raceDeleteReplica_true.shard1.replica_n2, tag=190887d9
[junit4] 2> 364244 INFO (coreCloseExecutor-1146-thread-1)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter Closing
reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@344cf85f: rootName
= solr_49027, domain = solr.core.raceDeleteReplica_true.shard1.replica_n2,
service url = null, agent id = null] for registry
solr.core.raceDeleteReplica_true.shard1.replica_n2 /
com.codahale.metrics.MetricRegistry@4db25983
[junit4] 2> 364254 INFO (coreCloseExecutor-1146-thread-1)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.m.SolrMetricManager Closing
metric reporters for
registry=solr.collection.raceDeleteReplica_true.shard1.leader, tag=190887d9
[junit4] 2> 364270 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.c.Overseer Overseer
(id=73766448193798155-127.0.0.1:49027_solr-n_0000000000) closing
[junit4] 2> 364270 INFO
(OverseerStateUpdate-73766448193798155-127.0.0.1:49027_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:49027_solr
[junit4] 2> 364273 WARN
(OverseerAutoScalingTriggerThread-73766448193798155-127.0.0.1:49027_solr-n_0000000000)
[ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we
are closed, exiting.
[junit4] 2> 364279 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
0x10612319cef000b, likely client has closed socket
[junit4] 2> 364279 INFO (zkCallback-3013-thread-3) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:39142_solr
[junit4] 2> 364280 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@36596210{/solr,null,UNAVAILABLE}
[junit4] 2> 364281 INFO (zkCallback-3013-thread-3) [ ]
o.a.s.c.Overseer Overseer
(id=73766448193798156-127.0.0.1:39142_solr-n_0000000001) starting
[junit4] 2> 364282 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.session Stopped scavenging
[junit4] 2> 364293 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/raceDeleteReplica_true/state.json] for collection
[raceDeleteReplica_true] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364293 INFO (zkCallback-3050-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/raceDeleteReplica_true/state.json] for collection
[raceDeleteReplica_true] has occurred - updating... (live nodes size: [3])
[junit4] 2> 364310 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp:
2017-11-21T21:27:37Z, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
[junit4] 2> 364322 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 364322 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 364322 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.session Scavenging every 600000ms
[junit4] 2> 364322 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1ff104a{/solr,null,AVAILABLE}
[junit4] 2> 364323 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.AbstractConnector Started ServerConnector@72167630{SSL,[ssl,
http/1.1]}{127.0.0.1:49027}
[junit4] 2> 364323 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.e.j.s.Server Started @364457ms
[junit4] 2> 364323 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49027}
[junit4] 2> 364324 ERROR
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging
may be missing or incomplete.
[junit4] 2> 364324 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 364324 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™
version 7.4.0
[junit4] 2> 364324 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on
port null
[junit4] 2> 364324 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 364324 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-05-08T23:45:53.767Z
[junit4] 2> 364335 INFO (zkConnectionManagerCallback-3053-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 364337 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 364359 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42585/solr
[junit4] 2> 364361 INFO (zkConnectionManagerCallback-3057-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 364363 INFO (zkConnectionManagerCallback-3059-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 364370 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 364373 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 364382 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 364382 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49027_solr
[junit4] 2> 364386 INFO (zkCallback-3043-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3050-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3038-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3006-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3033-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364386 INFO (zkCallback-3013-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364392 INFO (zkCallback-3058-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 364483 INFO (zkCallback-3011-thread-2) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/raceDeleteReplica_true/state.json] for collection
[raceDeleteReplica_true] has occurred - updating... (live nodes size: [4])
[junit4] 2> 364672 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 364685 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 364685 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_49027.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 364688 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4B4137FF3E44AD3F-001/tempDir-001/node4/.
[junit4] 2> 364688 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.CorePropertiesLocator Cores are:
[raceDeleteReplica_true_shard1_replica_n2]
[junit4] 2> 364694 INFO (zkConnectionManagerCallback-3066-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 364696 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 364698 INFO
(TEST-DeleteReplicaTest.raceConditionOnDeleteAndRegisterReplica-seed#[4B4137FF3E44AD3F])
[n:127.0.0.1:49027_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:42585/solr ready
[junit4] 2> 364712 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.4.0
[junit4] 2> 364742 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr ] o.a.s.s.IndexSchema
[raceDeleteReplica_true_shard1_replica_n2] Schema name=minimal
[junit4] 2> 364745 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr ] o.a.s.s.IndexSchema Loaded schema minimal/1.1 with
uniqueid field id
[junit4] 2> 364760 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.4.0
[junit4] 2> 364768 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.s.IndexSchema
[raceDeleteReplica_true_shard1_replica_n2] Schema name=minimal
[junit4] 2> 364771 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema
minimal/1.1 with uniqueid field id
[junit4] 2> 364771 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.CoreContainer Creating
SolrCore 'raceDeleteReplica_true_shard1_replica_n2' using configuration from
collection raceDeleteReplica_true, trusted=true
[junit4] 2> 364771 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX
monitoring for 'solr_49027.solr.core.raceDeleteReplica_true.shard1.replica_n2'
(registry 'solr.core.raceDeleteReplica_true.shard1.replica_n2') enabled at
server: com.sun.jmx.mbeanserver.JmxMBeanServer@15cdd42d
[junit4] 2> 364772 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 364772 INFO
(coreLoadExecutor-1157-thread-1-processing-n:127.0.0.1:49027_solr)
[n:127.0.0.1:49027_solr c:raceDeleteReplica_true s:shard1 r:core_node4
x:raceDeleteReplica_true_shard1_replica_n2] o.a.s.c.SolrCore
[[raceDeleteReplica_true_shard1_replica_n2] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/build/solr-core/test/J1/temp/solr.cloud.DeleteReplicaTest_4
[...truncated too long message...]
igure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1486709221
[copy] Copying 40 files to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1486709221
[delete] Deleting directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/null1486709221
resolve-example:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
resolve-server:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
ivy-availability-check:
[loadresource] Do not set property disallowed.ivy.jars.list as its length is 0.
-ivy-fail-disallowed-ivy-version:
ivy-fail:
ivy-fail:
ivy-configure:
[ivy:configure] :: loading settings :: file =
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1343271377
[copy] Copying 246 files to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1343271377
[delete] Deleting directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-7.x/solr/null1343271377
check-working-copy:
[ivy:cachepath] :: resolving dependencies ::
org.eclipse.jgit#org.eclipse.jgit-caller;working
[ivy:cachepath] confs: [default]
[ivy:cachepath] found
org.eclipse.jgit#org.eclipse.jgit;4.6.0.201612231935-r in public
[ivy:cachepath] found com.jcraft#jsch;0.1.53 in public
[ivy:cachepath] found com.googlecode.javaewah#JavaEWAH;1.1.6 in public
[ivy:cachepath] found org.apache.httpcomponents#httpclient;4.3.6 in
public
[ivy:cachepath] found org.apache.httpcomponents#httpcore;4.3.3 in public
[ivy:cachepath] found commons-logging#commons-logging;1.1.3 in public
[ivy:cachepath] found commons-codec#commons-codec;1.6 in public
[ivy:cachepath] found org.slf4j#slf4j-api;1.7.2 in public
[ivy:cachepath] :: resolution report :: resolve 66ms :: artifacts dl 7ms
---------------------------------------------------------------------
| | modules || artifacts |
| conf | number| search|dwnlded|evicted|| number|dwnlded|
---------------------------------------------------------------------
| default | 8 | 0 | 0 | 0 || 8 | 0 |
---------------------------------------------------------------------
[wc-checker] Initializing working copy...
[wc-checker] SLF4J: Failed to load class "org.slf4j.impl.StaticLoggerBinder".
[wc-checker] SLF4J: Defaulting to no-operation (NOP) logger implementation
[wc-checker] SLF4J: See http://www.slf4j.org/codes.html#StaticLoggerBinder for
further details.
[wc-checker] Checking working copy status...
-jenkins-base:
BUILD SUCCESSFUL
Total time: 162 minutes 38 seconds
Archiving artifacts
WARN: No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
WARN: java.lang.InterruptedException: no matches found within 10000
Recording test results
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]