Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-master/119/
3 tests failed.
FAILED: org.apache.solr.cloud.HttpPartitionTest.test
Error Message:
max version bucket seed not updated after recovery!
Stack Trace:
java.lang.AssertionError: max version bucket seed not updated after recovery!
at
__randomizedtesting.SeedInfo.seed([329D6BEA91C30D48:BAC954303F3F60B0]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.HttpPartitionTest.testRf2(HttpPartitionTest.java:449)
at
org.apache.solr.cloud.HttpPartitionTest.test(HttpPartitionTest.java:145)
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
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1008)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:983)
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:
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration
Error Message:
last state:
DocCollection(testSplitIntegration_collection//clusterstate.json/136)={
"replicationFactor":"1", "pullReplicas":"0",
"router":{"name":"compositeId"}, "maxShardsPerNode":"2",
"autoAddReplicas":"false", "nrtReplicas":"2", "tlogReplicas":"0",
"autoCreated":"true", "shards":{ "shard1_1_0":{ "state":"active",
"replicas":{ "core_node14":{
"core":"testSplitIntegration_collection_shard1_1_0_replica1",
"SEARCHER.searcher.maxDoc":6, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":23480, "node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":2.1867454051971436E-5,
"SEARCHER.searcher.numDocs":6}, "core_node13":{
"core":"testSplitIntegration_collection_shard1_1_0_replica0",
"SEARCHER.searcher.maxDoc":6, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":23480, "node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":2.1867454051971436E-5,
"SEARCHER.searcher.numDocs":6}}}, "shard2":{ "replicas":{
"core_node3":{
"core":"testSplitIntegration_collection_shard2_replica_n3",
"leader":"true", "SEARCHER.searcher.maxDoc":0,
"SEARCHER.searcher.deletedDocs":0, "INDEX.sizeInBytes":10240,
"node_name":"127.0.0.1:10155_solr", "state":"active",
"type":"NRT", "INDEX.sizeInGB":9.5367431640625E-6,
"SEARCHER.searcher.numDocs":0}, "core_node4":{
"core":"testSplitIntegration_collection_shard2_replica_n4",
"SEARCHER.searcher.maxDoc":0, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":10240, "node_name":"127.0.0.1:10154_solr",
"state":"active", "type":"NRT",
"INDEX.sizeInGB":9.5367431640625E-6, "SEARCHER.searcher.numDocs":0}},
"range":"0-7fffffff", "state":"active"}, "shard1":{
"stateTimestamp":"1533765809606776300", "replicas":{
"core_node1":{
"core":"testSplitIntegration_collection_shard1_replica_n1",
"leader":"true", "SEARCHER.searcher.maxDoc":25,
"SEARCHER.searcher.deletedDocs":0, "INDEX.sizeInBytes":22740,
"node_name":"127.0.0.1:10155_solr", "state":"active",
"type":"NRT", "INDEX.sizeInGB":2.117827534675598E-5,
"SEARCHER.searcher.numDocs":25}, "core_node2":{
"core":"testSplitIntegration_collection_shard1_replica_n2",
"SEARCHER.searcher.maxDoc":25, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":22740, "node_name":"127.0.0.1:10154_solr",
"state":"active", "type":"NRT",
"INDEX.sizeInGB":2.117827534675598E-5,
"SEARCHER.searcher.numDocs":25}}, "range":"80000000-ffffffff",
"state":"inactive"}, "shard1_1":{ "parent":"shard1",
"stateTimestamp":"1533765809607579350", "range":"c0000000-ffffffff",
"state":"active", "replicas":{ "core_node10":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_1_replica1",
"SEARCHER.searcher.maxDoc":12, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":16240, "node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":1.5124678611755371E-5,
"SEARCHER.searcher.numDocs":12}, "core_node9":{
"core":"testSplitIntegration_collection_shard1_1_replica0",
"SEARCHER.searcher.maxDoc":12, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":16240, "node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":1.5124678611755371E-5,
"SEARCHER.searcher.numDocs":12}}}, "shard1_0":{ "parent":"shard1",
"stateTimestamp":"1533765809607422850",
"range":"80000000-bfffffff", "state":"active", "replicas":{
"core_node7":{ "leader":"true",
"core":"testSplitIntegration_collection_shard1_0_replica0",
"SEARCHER.searcher.maxDoc":13, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":26980, "node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":2.512708306312561E-5,
"SEARCHER.searcher.numDocs":13}, "core_node8":{
"core":"testSplitIntegration_collection_shard1_0_replica1",
"SEARCHER.searcher.maxDoc":13, "SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":26980, "node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";, "state":"active",
"type":"NRT", "INDEX.sizeInGB":2.512708306312561E-5,
"SEARCHER.searcher.numDocs":13}}}}}
Stack Trace:
java.util.concurrent.TimeoutException: last state:
DocCollection(testSplitIntegration_collection//clusterstate.json/136)={
"replicationFactor":"1",
"pullReplicas":"0",
"router":{"name":"compositeId"},
"maxShardsPerNode":"2",
"autoAddReplicas":"false",
"nrtReplicas":"2",
"tlogReplicas":"0",
"autoCreated":"true",
"shards":{
"shard1_1_0":{
"state":"active",
"replicas":{
"core_node14":{
"core":"testSplitIntegration_collection_shard1_1_0_replica1",
"SEARCHER.searcher.maxDoc":6,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":23480,
"node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.1867454051971436E-5,
"SEARCHER.searcher.numDocs":6},
"core_node13":{
"core":"testSplitIntegration_collection_shard1_1_0_replica0",
"SEARCHER.searcher.maxDoc":6,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":23480,
"node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.1867454051971436E-5,
"SEARCHER.searcher.numDocs":6}}},
"shard2":{
"replicas":{
"core_node3":{
"core":"testSplitIntegration_collection_shard2_replica_n3",
"leader":"true",
"SEARCHER.searcher.maxDoc":0,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":10240,
"node_name":"127.0.0.1:10155_solr",
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":9.5367431640625E-6,
"SEARCHER.searcher.numDocs":0},
"core_node4":{
"core":"testSplitIntegration_collection_shard2_replica_n4",
"SEARCHER.searcher.maxDoc":0,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":10240,
"node_name":"127.0.0.1:10154_solr",
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":9.5367431640625E-6,
"SEARCHER.searcher.numDocs":0}},
"range":"0-7fffffff",
"state":"active"},
"shard1":{
"stateTimestamp":"1533765809606776300",
"replicas":{
"core_node1":{
"core":"testSplitIntegration_collection_shard1_replica_n1",
"leader":"true",
"SEARCHER.searcher.maxDoc":25,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":22740,
"node_name":"127.0.0.1:10155_solr",
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.117827534675598E-5,
"SEARCHER.searcher.numDocs":25},
"core_node2":{
"core":"testSplitIntegration_collection_shard1_replica_n2",
"SEARCHER.searcher.maxDoc":25,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":22740,
"node_name":"127.0.0.1:10154_solr",
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.117827534675598E-5,
"SEARCHER.searcher.numDocs":25}},
"range":"80000000-ffffffff",
"state":"inactive"},
"shard1_1":{
"parent":"shard1",
"stateTimestamp":"1533765809607579350",
"range":"c0000000-ffffffff",
"state":"active",
"replicas":{
"core_node10":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_1_replica1",
"SEARCHER.searcher.maxDoc":12,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":16240,
"node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":1.5124678611755371E-5,
"SEARCHER.searcher.numDocs":12},
"core_node9":{
"core":"testSplitIntegration_collection_shard1_1_replica0",
"SEARCHER.searcher.maxDoc":12,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":16240,
"node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":1.5124678611755371E-5,
"SEARCHER.searcher.numDocs":12}}},
"shard1_0":{
"parent":"shard1",
"stateTimestamp":"1533765809607422850",
"range":"80000000-bfffffff",
"state":"active",
"replicas":{
"core_node7":{
"leader":"true",
"core":"testSplitIntegration_collection_shard1_0_replica0",
"SEARCHER.searcher.maxDoc":13,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":26980,
"node_name":"127.0.0.1:10155_solr",
"base_url":"http://127.0.0.1:10155/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.512708306312561E-5,
"SEARCHER.searcher.numDocs":13},
"core_node8":{
"core":"testSplitIntegration_collection_shard1_0_replica1",
"SEARCHER.searcher.maxDoc":13,
"SEARCHER.searcher.deletedDocs":0,
"INDEX.sizeInBytes":26980,
"node_name":"127.0.0.1:10154_solr",
"base_url":"http://127.0.0.1:10154/solr";,
"state":"active",
"type":"NRT",
"INDEX.sizeInGB":2.512708306312561E-5,
"SEARCHER.searcher.numDocs":13}}}}}
at
__randomizedtesting.SeedInfo.seed([329D6BEA91C30D48:B13D2AABE3CC4B6]:0)
at
org.apache.solr.cloud.CloudTestUtils.waitForState(CloudTestUtils.java:111)
at
org.apache.solr.cloud.autoscaling.IndexSizeTriggerTest.testSplitIntegration(IndexSizeTriggerTest.java:313)
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: org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic
Error Message:
{ "dbLastUpdateTime":1000006030, "firstTimestamp":1000000020,
"lastTimestamp":1000006080,
"timestamps":[1000000020,1000000080,1000000140,1000000200,1000000260,1000000320,1000000380,1000000440,1000000500,1000000560,1000000620,1000000680,1000000740,1000000800,1000000860,1000000920,1000000980,1000001040,1000001100,1000001160,1000001220,1000001280,1000001340,1000001400,1000001460,1000001520,1000001580,1000001640,1000001700,1000001760,1000001820,1000001880,1000001940,1000002000,1000002060,1000002120,1000002180,1000002240,1000002300,1000002360,1000002420,1000002480,1000002540,1000002600,1000002660,1000002720,1000002780,1000002840,1000002900,1000002960,1000003020,1000003080,1000003140,1000003200,1000003260,1000003320,1000003380,1000003440,1000003500,1000003560,1000003620,1000003680,1000003740,1000003800,1000003860,1000003920,1000003980,1000004040,1000004100,1000004160,1000004220,1000004280,1000004340,1000004400,1000004460,1000004520,1000004580,1000004640,1000004700,1000004760,1000004820,1000004880,1000004940,1000005000,1000005060,1000005120,1000005180,1000005240,1000005300,1000005360,1000005420,1000005480,1000005540,1000005600,1000005660,1000005720,1000005780,1000005840,1000005900,1000005960,1000006020,1000006080],
"data":"1000000020: NaN +1.0000000000E02 \n1000000080: +1.0000000000E00
+1.0000000000E02 \n1000000140: +1.0000000000E00 +1.0000000000E02
\n1000000200: +1.0000000000E00 +1.0000000000E02 \n1000000260:
+1.0000000000E00 +1.0000000000E02 \n1000000320: +1.0000000000E00
+1.0000000000E02 \n1000000380: +1.0000000000E00 +1.0000000000E02
\n1000000440: +1.0000000000E00 +1.0000000000E02 \n1000000500:
+1.0000000000E00 +1.0000000000E02 \n1000000560: +1.0000000000E00
+1.0000000000E02 \n1000000620: +1.0000000000E00 +1.0000000000E02
\n1000000680: +1.0000000000E00 +1.0000000000E02 \n1000000740:
+1.0000000000E00 +1.0000000000E02 \n1000000800: +1.0000000000E00
+1.0000000000E02 \n1000000860: +1.0000000000E00 +1.0000000000E02
\n1000000920: +1.0000000000E00 +1.0000000000E02 \n1000000980:
+1.0000000000E00 +1.0000000000E02 \n1000001040: +1.0000000000E00
+1.0000000000E02 \n1000001100: +1.0000000000E00 +1.0000000000E02
\n1000001160: +1.0000000000E00 +1.0000000000E02 \n1000001220:
+1.0000000000E00 +1.0000000000E02 \n1000001280: +1.0000000000E00
+1.0000000000E02 \n1000001340: +1.0000000000E00 +1.0000000000E02
\n1000001400: +1.0000000000E00 +1.0000000000E02 \n1000001460:
+1.0000000000E00 +1.0000000000E02 \n1000001520: +1.0000000000E00
+1.0000000000E02 \n1000001580: +1.0000000000E00 +1.0000000000E02
\n1000001640: +1.0000000000E00 +1.0000000000E02 \n1000001700:
+1.0000000000E00 +1.0000000000E02 \n1000001760: +1.0000000000E00
+1.0000000000E02 \n1000001820: +1.0000000000E00 +1.0000000000E02
\n1000001880: +1.0000000000E00 +1.0000000000E02 \n1000001940:
+1.0000000000E00 +1.0000000000E02 \n1000002000: +1.0000000000E00
+1.0000000000E02 \n1000002060: +1.0000000000E00 +1.0000000000E02
\n1000002120: +1.0000000000E00 +1.0000000000E02 \n1000002180:
+1.0000000000E00 +1.0000000000E02 \n1000002240: +1.0000000000E00
+1.0000000000E02 \n1000002300: +1.0000000000E00 +1.0000000000E02
\n1000002360: +1.0000000000E00 +1.0000000000E02 \n1000002420:
+1.0000000000E00 +1.0000000000E02 \n1000002480: +1.0000000000E00
+1.0000000000E02 \n1000002540: +1.0000000000E00 +1.0000000000E02
\n1000002600: +1.0000000000E00 +1.0000000000E02 \n1000002660:
+1.0000000000E00 +1.0000000000E02 \n1000002720: +1.0000000000E00
+1.0000000000E02 \n1000002780: +1.0000000000E00 +1.0000000000E02
\n1000002840: +1.0000000000E00 +1.0000000000E02 \n1000002900:
+1.0000000000E00 +1.0000000000E02 \n1000002960: +1.0000000000E00
+1.0000000000E02 \n1000003020: +1.0000000000E00 +1.0000000000E02
\n1000003080: +1.0000000000E00 +1.0000000000E02 \n1000003140:
+1.0000000000E00 +1.0000000000E02 \n1000003200: +1.0000000000E00
+1.0000000000E02 \n1000003260: +1.0000000000E00 +1.0000000000E02
\n1000003320: +1.0000000000E00 +1.0000000000E02 \n1000003380: NaN NaN
\n1000003440: NaN NaN \n1000003500: NaN NaN \n1000003560: NaN NaN
\n1000003620: NaN NaN \n1000003680: NaN NaN \n1000003740: NaN NaN
\n1000003800: NaN NaN \n1000003860: NaN NaN \n1000003920: NaN NaN
\n1000003980: NaN NaN \n1000004040: NaN NaN \n1000004100: NaN NaN
\n1000004160: NaN NaN \n1000004220: NaN NaN \n1000004280: NaN NaN
\n1000004340: NaN NaN \n1000004400: NaN NaN \n1000004460: NaN NaN
\n1000004520: NaN NaN \n1000004580: NaN NaN \n1000004640: NaN NaN
\n1000004700: NaN NaN \n1000004760: NaN NaN \n1000004820: NaN NaN
\n1000004880: NaN NaN \n1000004940: NaN NaN \n1000005000: NaN NaN
\n1000005060: NaN NaN \n1000005120: NaN NaN \n1000005180: NaN NaN
\n1000005240: NaN NaN \n1000005300: NaN NaN \n1000005360: NaN NaN
\n1000005420: NaN NaN \n1000005480: NaN NaN \n1000005540: NaN NaN
\n1000005600: NaN NaN \n1000005660: NaN NaN \n1000005720: NaN NaN
\n1000005780: NaN NaN \n1000005840: NaN NaN \n1000005900: NaN NaN
\n1000005960: NaN NaN \n1000006020: NaN NaN \n1000006080: NaN NaN \n"}
expected:<1.0> but was:<NaN>
Stack Trace:
java.lang.AssertionError: {
"dbLastUpdateTime":1000006030,
"firstTimestamp":1000000020,
"lastTimestamp":1000006080,
"timestamps":[1000000020,1000000080,1000000140,1000000200,1000000260,1000000320,1000000380,1000000440,1000000500,1000000560,1000000620,1000000680,1000000740,1000000800,1000000860,1000000920,1000000980,1000001040,1000001100,1000001160,1000001220,1000001280,1000001340,1000001400,1000001460,1000001520,1000001580,1000001640,1000001700,1000001760,1000001820,1000001880,1000001940,1000002000,1000002060,1000002120,1000002180,1000002240,1000002300,1000002360,1000002420,1000002480,1000002540,1000002600,1000002660,1000002720,1000002780,1000002840,1000002900,1000002960,1000003020,1000003080,1000003140,1000003200,1000003260,1000003320,1000003380,1000003440,1000003500,1000003560,1000003620,1000003680,1000003740,1000003800,1000003860,1000003920,1000003980,1000004040,1000004100,1000004160,1000004220,1000004280,1000004340,1000004400,1000004460,1000004520,1000004580,1000004640,1000004700,1000004760,1000004820,1000004880,1000004940,1000005000,1000005060,1000005120,1000005180,1000005240,1000005300,1000005360,1000005420,1000005480,1000005540,1000005600,1000005660,1000005720,1000005780,1000005840,1000005900,1000005960,1000006020,1000006080],
"data":"1000000020: NaN +1.0000000000E02 \n1000000080: +1.0000000000E00
+1.0000000000E02 \n1000000140: +1.0000000000E00 +1.0000000000E02
\n1000000200: +1.0000000000E00 +1.0000000000E02 \n1000000260:
+1.0000000000E00 +1.0000000000E02 \n1000000320: +1.0000000000E00
+1.0000000000E02 \n1000000380: +1.0000000000E00 +1.0000000000E02
\n1000000440: +1.0000000000E00 +1.0000000000E02 \n1000000500:
+1.0000000000E00 +1.0000000000E02 \n1000000560: +1.0000000000E00
+1.0000000000E02 \n1000000620: +1.0000000000E00 +1.0000000000E02
\n1000000680: +1.0000000000E00 +1.0000000000E02 \n1000000740:
+1.0000000000E00 +1.0000000000E02 \n1000000800: +1.0000000000E00
+1.0000000000E02 \n1000000860: +1.0000000000E00 +1.0000000000E02
\n1000000920: +1.0000000000E00 +1.0000000000E02 \n1000000980:
+1.0000000000E00 +1.0000000000E02 \n1000001040: +1.0000000000E00
+1.0000000000E02 \n1000001100: +1.0000000000E00 +1.0000000000E02
\n1000001160: +1.0000000000E00 +1.0000000000E02 \n1000001220:
+1.0000000000E00 +1.0000000000E02 \n1000001280: +1.0000000000E00
+1.0000000000E02 \n1000001340: +1.0000000000E00 +1.0000000000E02
\n1000001400: +1.0000000000E00 +1.0000000000E02 \n1000001460:
+1.0000000000E00 +1.0000000000E02 \n1000001520: +1.0000000000E00
+1.0000000000E02 \n1000001580: +1.0000000000E00 +1.0000000000E02
\n1000001640: +1.0000000000E00 +1.0000000000E02 \n1000001700:
+1.0000000000E00 +1.0000000000E02 \n1000001760: +1.0000000000E00
+1.0000000000E02 \n1000001820: +1.0000000000E00 +1.0000000000E02
\n1000001880: +1.0000000000E00 +1.0000000000E02 \n1000001940:
+1.0000000000E00 +1.0000000000E02 \n1000002000: +1.0000000000E00
+1.0000000000E02 \n1000002060: +1.0000000000E00 +1.0000000000E02
\n1000002120: +1.0000000000E00 +1.0000000000E02 \n1000002180:
+1.0000000000E00 +1.0000000000E02 \n1000002240: +1.0000000000E00
+1.0000000000E02 \n1000002300: +1.0000000000E00 +1.0000000000E02
\n1000002360: +1.0000000000E00 +1.0000000000E02 \n1000002420:
+1.0000000000E00 +1.0000000000E02 \n1000002480: +1.0000000000E00
+1.0000000000E02 \n1000002540: +1.0000000000E00 +1.0000000000E02
\n1000002600: +1.0000000000E00 +1.0000000000E02 \n1000002660:
+1.0000000000E00 +1.0000000000E02 \n1000002720: +1.0000000000E00
+1.0000000000E02 \n1000002780: +1.0000000000E00 +1.0000000000E02
\n1000002840: +1.0000000000E00 +1.0000000000E02 \n1000002900:
+1.0000000000E00 +1.0000000000E02 \n1000002960: +1.0000000000E00
+1.0000000000E02 \n1000003020: +1.0000000000E00 +1.0000000000E02
\n1000003080: +1.0000000000E00 +1.0000000000E02 \n1000003140:
+1.0000000000E00 +1.0000000000E02 \n1000003200: +1.0000000000E00
+1.0000000000E02 \n1000003260: +1.0000000000E00 +1.0000000000E02
\n1000003320: +1.0000000000E00 +1.0000000000E02 \n1000003380: NaN NaN
\n1000003440: NaN NaN \n1000003500: NaN NaN \n1000003560: NaN NaN
\n1000003620: NaN NaN \n1000003680: NaN NaN \n1000003740: NaN NaN
\n1000003800: NaN NaN \n1000003860: NaN NaN \n1000003920: NaN NaN
\n1000003980: NaN NaN \n1000004040: NaN NaN \n1000004100: NaN NaN
\n1000004160: NaN NaN \n1000004220: NaN NaN \n1000004280: NaN NaN
\n1000004340: NaN NaN \n1000004400: NaN NaN \n1000004460: NaN NaN
\n1000004520: NaN NaN \n1000004580: NaN NaN \n1000004640: NaN NaN
\n1000004700: NaN NaN \n1000004760: NaN NaN \n1000004820: NaN NaN
\n1000004880: NaN NaN \n1000004940: NaN NaN \n1000005000: NaN NaN
\n1000005060: NaN NaN \n1000005120: NaN NaN \n1000005180: NaN NaN
\n1000005240: NaN NaN \n1000005300: NaN NaN \n1000005360: NaN NaN
\n1000005420: NaN NaN \n1000005480: NaN NaN \n1000005540: NaN NaN
\n1000005600: NaN NaN \n1000005660: NaN NaN \n1000005720: NaN NaN
\n1000005780: NaN NaN \n1000005840: NaN NaN \n1000005900: NaN NaN
\n1000005960: NaN NaN \n1000006020: NaN NaN \n1000006080: NaN NaN \n"}
expected:<1.0> but was:<NaN>
at
__randomizedtesting.SeedInfo.seed([329D6BEA91C30D48:996776FF4E1F8B66]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:443)
at
org.apache.solr.metrics.rrd.SolrRrdBackendFactoryTest.testBasic(SolrRrdBackendFactoryTest.java:162)
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 12290 lines...]
[junit4] Suite: org.apache.solr.cloud.HttpPartitionTest
[junit4] 2> 179137 INFO
(SUITE-HttpPartitionTest-seed#[329D6BEA91C30D48]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/init-core-data-001
[junit4] 2> 179137 WARN
(SUITE-HttpPartitionTest-seed#[329D6BEA91C30D48]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=11 numCloses=11
[junit4] 2> 179138 INFO
(SUITE-HttpPartitionTest-seed#[329D6BEA91C30D48]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 179139 INFO
(SUITE-HttpPartitionTest-seed#[329D6BEA91C30D48]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 179139 INFO
(SUITE-HttpPartitionTest-seed#[329D6BEA91C30D48]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/wztl/hb
[junit4] 2> 179183 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 179183 INFO (Thread-154) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 179183 INFO (Thread-154) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 179189 ERROR (Thread-154) [ ] 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> 179283 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkTestServer start zk server on port:42367
[junit4] 2> 179290 INFO (zkConnectionManagerCallback-639-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179306 INFO (zkConnectionManagerCallback-641-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179311 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 179313 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 179314 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 179316 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 179317 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 179318 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 179319 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 179320 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 179322 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 179323 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 179324 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 179326 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 179443 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
[junit4] 2> 179444 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 179444 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session No
SessionScavenger set, using defaults
[junit4] 2> 179444 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
node0 Scavenging every 660000ms
[junit4] 2> 179445 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3a95658b{/wztl/hb,null,AVAILABLE}
[junit4] 2> 179451 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@204ae17e{HTTP/1.1,[http/1.1]}{127.0.0.1:40442}
[junit4] 2> 179451 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
Started @179491ms
[junit4] 2> 179451 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/tempDir-001/control/data,
replicaType=NRT, hostContext=/wztl/hb, hostPort=43029,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/control-001/cores}
[junit4] 2> 179454 ERROR
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 179454 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 179454 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 179454 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 179454 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 179454 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-08-07T21:55:26.940Z
[junit4] 2> 179457 INFO (zkConnectionManagerCallback-643-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179458 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 179458 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/control-001/solr.xml
[junit4] 2> 179462 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 179462 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 179463 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 179563 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42367/solr
[junit4] 2> 179565 INFO (zkConnectionManagerCallback-647-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179568 INFO (zkConnectionManagerCallback-649-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179651 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:43029_wztl%2Fhb
[junit4] 2> 179652 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.c.Overseer Overseer
(id=72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000) starting
[junit4] 2> 179660 INFO (zkConnectionManagerCallback-656-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179673 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.c.s.i.ZkClientClusterStateProvider
Cluster at 127.0.0.1:42367/solr ready
[junit4] 2> 179674 INFO
(OverseerStateUpdate-72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000)
[ ] o.a.s.c.Overseer Starting to work on the main queue :
127.0.0.1:43029_wztl%2Fhb
[junit4] 2> 179674 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43029_wztl%2Fhb
[junit4] 2> 179675 INFO
(OverseerStateUpdate-72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000)
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 179676 INFO (zkCallback-655-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 179695 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 179712 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 179719 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 179719 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 179721 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48])
[n:127.0.0.1:43029_wztl%2Fhb ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/control-001/cores
[junit4] 2> 179741 INFO (zkConnectionManagerCallback-662-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 179742 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 179743 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42367/solr ready
[junit4] 2> 179744 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=39458,localport=43029], receiveBufferSize:531000
[junit4] 2> 179754 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=40442,localport=57150], receiveBufferSize=530904
[junit4] 2> 179764 INFO (qtp871706531-2616) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:43029_wztl%252Fhb&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 179767 INFO (OverseerThreadFactory-559-thread-1) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 179874 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=39462,localport=43029], receiveBufferSize:531000
[junit4] 2> 179875 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=40442,localport=57154], receiveBufferSize=530904
[junit4] 2> 179896 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
x:control_collection_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core
create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 179896 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
x:control_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 180935 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
[junit4] 2> 180949 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 181051 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 181075 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from collection control_collection, trusted=true
[junit4] 2> 181076 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.replica_n1' (registry
'solr.core.control_collection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 181077 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
[junit4] 2> 181077 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore
at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/control-001/cores/control_collection_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 181080 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=39, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.5009765625,
floorSegmentMB=0.61328125, forceMergeDeletesPctAllowed=22.643336446340513,
segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0,
deletesPctAllowed=35.263193355498515
[junit4] 2> 181082 WARN (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 181130 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 181130 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 181131 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 181131 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 181132 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 181133 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@54aaa7d6[control_collection_shard1_replica_n1] main]
[junit4] 2> 181134 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 181135 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 181135 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 181136 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1608178916258742272
[junit4] 2> 181139 INFO
(searcherExecutor-564-thread-1-processing-n:127.0.0.1:43029_wztl%2Fhb
x:control_collection_shard1_replica_n1 c:control_collection s:shard1)
[n:127.0.0.1:43029_wztl%2Fhb c:control_collection s:shard1
x:control_collection_shard1_replica_n1] o.a.s.c.SolrCore
[control_collection_shard1_replica_n1] Registered new searcher
Searcher@54aaa7d6[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 181146 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/control_collection/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:43029/wztl/hb/control_collection_shard1_replica_n1/
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.SyncStrategy
http://127.0.0.1:43029/wztl/hb/control_collection_shard1_replica_n1/ has no
replicas
[junit4] 2> 181150 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 181155 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:43029/wztl/hb/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 181258 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 181264 INFO (qtp871706531-2611) [n:127.0.0.1:43029_wztl%2Fhb
c:control_collection s:shard1 x:control_collection_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1368
[junit4] 2> 181275 INFO (qtp871706531-2616) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 181361 INFO (zkCallback-648-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 181771 INFO
(OverseerCollectionConfigSetProcessor-72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 182275 INFO (qtp871706531-2616) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:43029_wztl%252Fhb&wt=javabin&version=2}
status=0 QTime=2511
[junit4] 2> 182294 INFO (zkConnectionManagerCallback-667-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 182295 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 182296 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42367/solr ready
[junit4] 2> 182296 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 182297 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=39534,localport=43029], receiveBufferSize:531000
[junit4] 2> 182298 INFO (SocketProxy-Acceptor-43029) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=40442,localport=57226], receiveBufferSize=530904
[junit4] 2> 182309 INFO (qtp871706531-2618) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 182319 INFO (OverseerThreadFactory-559-thread-2) [ ]
o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 182525 WARN (OverseerThreadFactory-559-thread-2) [ ]
o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection
(collection1) without cores.
[junit4] 2> 182529 INFO (qtp871706531-2618) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 182530 INFO
(OverseerCollectionConfigSetProcessor-72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 182533 INFO (qtp871706531-2618) [n:127.0.0.1:43029_wztl%2Fhb
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2}
status=0 QTime=224
[junit4] 2> 182665 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001
of type NRT
[junit4] 2> 182666 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
[junit4] 2> 182667 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 182667 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session No
SessionScavenger set, using defaults
[junit4] 2> 182668 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
node0 Scavenging every 600000ms
[junit4] 2> 182668 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@62078fc3{/wztl/hb,null,AVAILABLE}
[junit4] 2> 182672 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@56f8b794{HTTP/1.1,[http/1.1]}{127.0.0.1:45002}
[junit4] 2> 182672 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
Started @182711ms
[junit4] 2> 182672 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/wztl/hb, hostPort=36592,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001/cores}
[junit4] 2> 182675 ERROR
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 182675 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 182675 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 182675 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 182675 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 182675 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-08-07T21:55:30.161Z
[junit4] 2> 182677 INFO (zkConnectionManagerCallback-669-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 182678 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 182679 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001/solr.xml
[junit4] 2> 182682 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 182683 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 182684 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 182745 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42367/solr
[junit4] 2> 182747 INFO (zkConnectionManagerCallback-673-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 182752 INFO (zkConnectionManagerCallback-675-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 182760 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 182765 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 182765 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36592_wztl%2Fhb
[junit4] 2> 182766 INFO (zkCallback-648-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 182766 INFO (zkCallback-655-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 182766 INFO (zkCallback-666-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 182768 INFO (zkCallback-674-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 182786 INFO (zkConnectionManagerCallback-682-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 182787 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 182788 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42367/solr ready
[junit4] 2> 182788 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 182806 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 182826 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 182827 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 182828 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001/cores
[junit4] 2> 182855 INFO (SocketProxy-Acceptor-36592) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=36346,localport=36592], receiveBufferSize:531000
[junit4] 2> 182855 INFO (SocketProxy-Acceptor-36592) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=45002,localport=54474], receiveBufferSize=530904
[junit4] 2> 182871 INFO (qtp878595995-2677) [n:127.0.0.1:36592_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:36592_wztl%252Fhb&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 182884 INFO (OverseerThreadFactory-559-thread-3) [
c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Node Identified
127.0.0.1:36592_wztl%2Fhb for creating new replica of shard shard2
[junit4] 2> 182887 INFO (SocketProxy-Acceptor-36592) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=36350,localport=36592], receiveBufferSize:531000
[junit4] 2> 182887 INFO (SocketProxy-Acceptor-36592) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=45002,localport=54478], receiveBufferSize=530904
[junit4] 2> 182912 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
x:collection1_shard2_replica_n41] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 183933 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 183946 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema
[collection1_shard2_replica_n41] Schema name=test
[junit4] 2> 184067 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 184095 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard2_replica_n41' using configuration from
collection collection1, trusted=true
[junit4] 2> 184096 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_n41' (registry
'solr.core.collection1.shard2.replica_n41') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 184097 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 184097 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
[[collection1_shard2_replica_n41] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001/cores/collection1_shard2_replica_n41],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-1-001/cores/collection1_shard2_replica_n41/data/]
[junit4] 2> 184105 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=39, maxMergeAtOnceExplicit=23, maxMergedSegmentMB=27.5009765625,
floorSegmentMB=0.61328125, forceMergeDeletesPctAllowed=22.643336446340513,
segmentsPerTier=30.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0,
deletesPctAllowed=35.263193355498515
[junit4] 2> 184108 WARN (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 184169 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 184169 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 184170 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 184170 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 184171 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=27, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 184172 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@478aea56[collection1_shard2_replica_n41] main]
[junit4] 2> 184195 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 184195 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 184196 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 184197 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1608178919467384832
[junit4] 2> 184206 INFO
(searcherExecutor-578-thread-1-processing-n:127.0.0.1:36592_wztl%2Fhb
x:collection1_shard2_replica_n41 c:collection1 s:shard2)
[n:127.0.0.1:36592_wztl%2Fhb c:collection1 s:shard2
x:collection1_shard2_replica_n41] o.a.s.c.SolrCore
[collection1_shard2_replica_n41] Registered new searcher
Searcher@478aea56[collection1_shard2_replica_n41]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 184211 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/collection1/terms/shard2 to
Terms{values={core_node42=0}, version=0}
[junit4] 2> 184219 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 184219 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 184219 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:36592/wztl/hb/collection1_shard2_replica_n41/
[junit4] 2> 184220 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 184220 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.SyncStrategy
http://127.0.0.1:36592/wztl/hb/collection1_shard2_replica_n41/ has no replicas
[junit4] 2> 184220 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 184224 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:36592/wztl/hb/collection1_shard2_replica_n41/ shard2
[junit4] 2> 184326 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 184328 INFO (qtp878595995-2672) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 s:shard2 x:collection1_shard2_replica_n41] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n41&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1416
[junit4] 2> 184343 INFO (qtp878595995-2677) [n:127.0.0.1:36592_wztl%2Fhb
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:36592_wztl%252Fhb&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
status=0 QTime=1472
[junit4] 2> 184437 INFO (zkCallback-674-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 184535 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-2-001
of type NRT
[junit4] 2> 184536 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
jetty-9.4.11.v20180605; built: 2018-06-05T18:24:03.829Z; git:
d5fc0523cfa96bfebfbda19606cad384d772f04c; jvm 1.8.0_172-b11
[junit4] 2> 184537 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
DefaultSessionIdManager workerName=node0
[junit4] 2> 184537 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session No
SessionScavenger set, using defaults
[junit4] 2> 184537 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.session
node0 Scavenging every 600000ms
[junit4] 2> 184538 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6c79e853{/wztl/hb,null,AVAILABLE}
[junit4] 2> 184538 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@734aabe{HTTP/1.1,[http/1.1]}{127.0.0.1:43518}
[junit4] 2> 184538 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ] o.e.j.s.Server
Started @184578ms
[junit4] 2> 184538 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/tempDir-001/jetty2,
replicaType=NRT, solrconfig=solrconfig.xml, hostContext=/wztl/hb,
hostPort=46584,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-2-001/cores}
[junit4] 2> 184539 ERROR
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 184542 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 184542 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 184542 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 184542 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 184542 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2018-08-07T21:55:32.028Z
[junit4] 2> 184548 INFO (zkConnectionManagerCallback-685-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 184550 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 184550 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-2-001/solr.xml
[junit4] 2> 184555 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay
is ignored
[junit4] 2> 184555 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig Configuration parameter
autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 184557 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 184619 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42367/solr
[junit4] 2> 184621 INFO (zkConnectionManagerCallback-689-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 184623 INFO (zkConnectionManagerCallback-691-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 184629 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 184633 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 184634 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:46584_wztl%2Fhb
[junit4] 2> 184635 INFO (zkCallback-666-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184635 INFO (zkCallback-674-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184636 INFO (zkCallback-681-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184636 INFO (zkCallback-690-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184637 INFO (zkCallback-655-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184637 INFO (zkCallback-648-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 184654 INFO (zkConnectionManagerCallback-698-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 184655 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 184656 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42367/solr ready
[junit4] 2> 184657 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history
in memory.
[junit4] 2> 184673 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 184681 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 184681 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@3c033c52
[junit4] 2> 184683 INFO
(TEST-HttpPartitionTest.test-seed#[329D6BEA91C30D48]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/build/solr-core/test/J0/temp/solr.cloud.HttpPartitionTest_329D6BEA91C30D48-001/shard-2-001/cores
[junit4] 2> 184729 INFO (qtp878595995-2673) [n:127.0.0.1:36592_wztl%2Fhb
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:46584_wztl%252Fhb&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 184734 INFO
(OverseerCollectionConfigSetProcessor-72121012726923268-127.0.0.1:43029_wztl%2Fhb-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 184737 INFO (OverseerThreadFactory-559-thread-4) [
c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified
127.0.0.1:46584_wztl%2Fhb for creating new replica of shard shard1
[junit4] 2> 184740 INFO (SocketProxy-Acceptor-46584) [ ]
o.a.s.c.SocketProxy accepted
Socket[addr=/127.0.0.1,port=39528,localport=46584], receiveBufferSize:531000
[junit4] 2> 184751 INFO (SocketProxy-Acceptor-46584) [ ]
o.a.s.c.SocketProxy proxy connection
Socket[addr=/127.0.0.1,port=43518,localport=41640], receiveBufferSize=530904
[junit4] 2> 184766 INFO (qtp11056582-2720) [n:127.0.0.1:46584_wztl%2Fhb
x:collection1_shard1_replica_n43] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n43&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 184870 INFO (zkCallback-674-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 185799 INFO (qtp11056582-2720) [n:127.0.0.1:46584_wztl%2Fhb
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 185817 INFO (qtp11056582-2720) [n:127.0.0.1:46584_wztl%2Fhb
c:collection1 s:shard1 x:collection1_shard1_replica_n43] o.a.s.s.IndexSchema
[coll
[...truncated too long message...]
ns-slave/workspace/Lucene-Solr-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/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-BadApples-Tests-master/lucene/top-level-ivy-settings.xml
resolve:
jar-checksums:
[mkdir] Created dir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1511251558
[copy] Copying 238 files to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1511251558
[delete] Deleting directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-master/solr/null1511251558
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 31ms :: artifacts dl 1ms
---------------------------------------------------------------------
| | 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: 99 minutes 26 seconds
Archiving artifacts
java.lang.InterruptedException: no matches found within 10000
at hudson.FilePath$34.hasMatch(FilePath.java:2678)
at hudson.FilePath$34.invoke(FilePath.java:2557)
at hudson.FilePath$34.invoke(FilePath.java:2547)
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2918)
Also: hudson.remoting.Channel$CallSiteStackTrace: Remote call to lucene
at
hudson.remoting.Channel.attachCallSiteStackTrace(Channel.java:1741)
at
hudson.remoting.UserRequest$ExceptionResponse.retrieve(UserRequest.java:357)
at hudson.remoting.Channel.call(Channel.java:955)
at hudson.FilePath.act(FilePath.java:1036)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at
hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at
hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at
hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
Caused: hudson.FilePath$TunneledInterruptedException
at hudson.FilePath$FileCallableWrapper.call(FilePath.java:2920)
at hudson.remoting.UserRequest.perform(UserRequest.java:212)
at hudson.remoting.UserRequest.perform(UserRequest.java:54)
at hudson.remoting.Request$2.run(Request.java:369)
at
hudson.remoting.InterceptingExecutorService$1.call(InterceptingExecutorService.java:72)
at java.util.concurrent.FutureTask.run(FutureTask.java:266)
at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
at java.lang.Thread.run(Thread.java:748)
Caused: java.lang.InterruptedException: java.lang.InterruptedException: no
matches found within 10000
at hudson.FilePath.act(FilePath.java:1038)
at hudson.FilePath.act(FilePath.java:1025)
at hudson.FilePath.validateAntFileMask(FilePath.java:2547)
at hudson.tasks.ArtifactArchiver.perform(ArtifactArchiver.java:243)
at
hudson.tasks.BuildStepCompatibilityLayer.perform(BuildStepCompatibilityLayer.java:81)
at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20)
at
hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBuild.java:744)
at
hudson.model.AbstractBuild$AbstractBuildExecution.performAllBuildSteps(AbstractBuild.java:690)
at hudson.model.Build$BuildExecution.post2(Build.java:186)
at
hudson.model.AbstractBuild$AbstractBuildExecution.post(AbstractBuild.java:635)
at hudson.model.Run.execute(Run.java:1819)
at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43)
at hudson.model.ResourceController.execute(ResourceController.java:97)
at hudson.model.Executor.run(Executor.java:429)
No artifacts found that match the file pattern
"**/*.events,heapdumps/**,**/hs_err_pid*". Configuration error?
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]
