You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2017/11/18 21:22:18 UTC

[JENKINS] Lucene-Solr-7.x-Linux (64bit/jdk-9.0.1) - Build # 850 - Still Unstable!

Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/850/
Java: 64bit/jdk-9.0.1 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  junit.framework.TestSuite.org.apache.solr.analytics.facet.RangeFacetTest

Error Message:
There are still nodes recoverying - waited for 90 seconds

Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 90 seconds
	at __randomizedtesting.SeedInfo.seed([53A8356709A986C4]:0)
	at org.junit.Assert.fail(Assert.java:93)
	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:185)
	at org.apache.solr.analytics.SolrAnalyticsTestCase.setupCollection(SolrAnalyticsTestCase.java:63)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.base/java.lang.reflect.Method.invoke(Method.java:564)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:874)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
	at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
	at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
	at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
	at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
	at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 17140 lines...]
   [junit4] Suite: org.apache.solr.analytics.facet.RangeFacetTest
   [junit4]   2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/contrib/solr-analytics/test/J2/temp/solr.analytics.facet.RangeFacetTest_53A8356709A986C4-001/init-core-data-001
   [junit4]   1> / (12)
   [junit4]   1>  /configs (1)
   [junit4]   1>   /configs/conf (2)
   [junit4]   1>    /configs/conf/schema.xml (0)
   [junit4]   1>    DATA: ...supressed...
   [junit4]   1>    /configs/conf/solrconfig.xml (0)
   [junit4]   1>    DATA: ...supressed...
   [junit4]   1>  /overseer (6)
   [junit4]   1>  DATA:
   [junit4]   1>      
   [junit4]   1>   /overseer/collection-queue-work (0)
   [junit4]   1>   /overseer/queue-work (0)
   [junit4]   1>   /overseer/collection-map-failure (0)
   [junit4]   1>   /overseer/collection-map-completed (0)
   [junit4]   1>   /overseer/queue (2)
   [junit4]   1>    /overseer/queue/qn-0000000009 (0)
   [junit4]   1>    DATA:
   [junit4]   1>        {
   [junit4]   1>          "core":"collection1_shard1_replica_n1",
   [junit4]   1>          "core_node_name":"core_node2",
   [junit4]   1>          "roles":null,
   [junit4]   1>          "base_url":"https://127.0.0.1:34085/solr",
   [junit4]   1>          "node_name":"127.0.0.1:34085_solr",
   [junit4]   1>          "numShards":"2",
   [junit4]   1>          "state":"active",
   [junit4]   1>          "shard":"shard1",
   [junit4]   1>          "collection":"collection1",
   [junit4]   1>          "type":"NRT",
   [junit4]   1>          "operation":"state"}
   [junit4]   1>    /overseer/queue/qn-0000000008 (0)
   [junit4]   1>    DATA:
   [junit4]   1>        {
   [junit4]   1>          "core":"collection1_shard2_replica_n3",
   [junit4]   1>          "core_node_name":"core_node4",
   [junit4]   1>          "roles":null,
   [junit4]   1>          "base_url":"https://127.0.0.1:41133/solr",
   [junit4]   1>          "node_name":"127.0.0.1:41133_solr",
   [junit4]   1>          "numShards":"2",
   [junit4]   1>          "state":"active",
   [junit4]   1>          "shard":"shard2",
   [junit4]   1>          "collection":"collection1",
   [junit4]   1>          "type":"NRT",
   [junit4]   1>          "operation":"state"}
   [junit4]   1>   /overseer/collection-map-running (0)
   [junit4]   1>  /aliases.json (0)
   [junit4]   1>  /live_nodes (4)
   [junit4]   1>   /live_nodes/127.0.0.1:42161_solr (0)
   [junit4]   1>   /live_nodes/127.0.0.1:41133_solr (0)
   [junit4]   1>   /live_nodes/127.0.0.1:35497_solr (0)
   [junit4]   1>   /live_nodes/127.0.0.1:34085_solr (0)
   [junit4]   1>  /collections (1)
   [junit4]   1>   /collections/collection1 (4)
   [junit4]   1>   DATA:
   [junit4]   1>       {"configName":"conf"}
   [junit4]   1>    /collections/collection1/leaders (2)
   [junit4]   1>     /collections/collection1/leaders/shard2 (1)
   [junit4]   1>      /collections/collection1/leaders/shard2/leader (0)
   [junit4]   1>      DATA:
   [junit4]   1>          {
   [junit4]   1>            "core":"collection1_shard2_replica_n3",
   [junit4]   1>            "core_node_name":"core_node4",
   [junit4]   1>            "base_url":"https://127.0.0.1:41133/solr",
   [junit4]   1>            "node_name":"127.0.0.1:41133_solr"}
   [junit4]   1>     /collections/collection1/leaders/shard1 (1)
   [junit4]   1>      /collections/collection1/leaders/shard1/leader (0)
   [junit4]   1>      DATA:
   [junit4]   1>          {
   [junit4]   1>            "core":"collection1_shard1_replica_n1",
   [junit4]   1>            "core_node_name":"core_node2",
   [junit4]   1>            "base_url":"https://127.0.0.1:34085/solr",
   [junit4]   1>            "node_name":"127.0.0.1:34085_solr"}
   [junit4]   1>    /collections/collection1/counter (0)
   [junit4]   1>    DATA:
   [junit4]   1>        
   [junit4]   1>    /collections/collection1/state.json (0)
   [junit4]   1>    DATA:
   [junit4]   1>        {"collection1":{
   [junit4]   1>            "pullReplicas":"0",
   [junit4]   1>            "replicationFactor":"1",
   [junit4]   1>            "router":{"name":"compositeId"},
   [junit4]   1>            "maxShardsPerNode":"1",
   [junit4]   1>            "autoAddReplicas":"false",
   [junit4]   1>            "nrtReplicas":"1",
   [junit4]   1>            "tlogReplicas":"0",
   [junit4]   1>            "shards":{
   [junit4]   1>              "shard1":{
   [junit4]   1>                "range":"80000000-ffffffff",
   [junit4]   1>                "state":"active",
   [junit4]   1>                "replicas":{"core_node2":{
   [junit4]   1>                    "core":"collection1_shard1_replica_n1",
   [junit4]   1>                    "base_url":"https://127.0.0.1:34085/solr",
   [junit4]   1>                    "node_name":"127.0.0.1:34085_solr",
   [junit4]   1>                    "state":"down",
   [junit4]   1>                    "type":"NRT",
   [junit4]   1>                    "leader":"true"}}},
   [junit4]   1>              "shard2":{
   [junit4]   1>                "range":"0-7fffffff",
   [junit4]   1>                "state":"active",
   [junit4]   1>                "replicas":{"core_node4":{
   [junit4]   1>                    "core":"collection1_shard2_replica_n3",
   [junit4]   1>                    "base_url":"https://127.0.0.1:41133/solr",
   [junit4]   1>                    "node_name":"127.0.0.1:41133_solr",
   [junit4]   1>                    "state":"down",
   [junit4]   1>                    "type":"NRT",
   [junit4]   1>                    "leader":"true"}}}}}}
   [junit4]   1>    /collections/collection1/leader_elect (2)
   [junit4]   1>     /collections/collection1/leader_elect/shard2 (1)
   [junit4]   1>      /collections/collection1/leader_elect/shard2/election (1)
   [junit4]   1>       /collections/collection1/leader_elect/shard2/election/99027492440375305-core_node4-n_0000000000 (0)
   [junit4]   1>     /collections/collection1/leader_elect/shard1 (1)
   [junit4]   1>      /collections/collection1/leader_elect/shard1/election (1)
   [junit4]   1>       /collections/collection1/leader_elect/shard1/election/99027492440375307-core_node2-n_0000000000 (0)
   [junit4]   1>  /overseer_elect (2)
   [junit4]   1>   /overseer_elect/leader (0)
   [junit4]   1>   DATA:
   [junit4]   1>       {"id":"99027492440375305-127.0.0.1:41133_solr-n_0000000000"}
   [junit4]   1>   /overseer_elect/election (4)
   [junit4]   1>    /overseer_elect/election/99027492440375305-127.0.0.1:41133_solr-n_0000000000 (0)
   [junit4]   1>    /overseer_elect/election/99027492440375306-127.0.0.1:35497_solr-n_0000000001 (0)
   [junit4]   1>    /overseer_elect/election/99027492440375308-127.0.0.1:42161_solr-n_0000000002 (0)
   [junit4]   1>    /overseer_elect/election/99027492440375307-127.0.0.1:34085_solr-n_0000000003 (0)
   [junit4]   1>  /security.json (0)
   [junit4]   1>  DATA:
   [junit4]   1>      {}
   [junit4]   1>  /clusterstate.json (0)
   [junit4]   1>  DATA:
   [junit4]   1>      {}
   [junit4]   1>  /solr.xml (0)
   [junit4]   1>  DATA: ...supressed...
   [junit4]   1>  /autoscaling (4)
   [junit4]   1>   /autoscaling/nodeAdded (0)
   [junit4]   1>   /autoscaling/nodeLost (0)
   [junit4]   1>   /autoscaling/triggerState (1)
   [junit4]   1>    /autoscaling/triggerState/.auto_add_replicas (0)
   [junit4]   1>    DATA:
   [junit4]   1>        {
   [junit4]   1>          "lastLiveNodes":[
   [junit4]   1>            "127.0.0.1:34085_solr",
   [junit4]   1>            "127.0.0.1:35497_solr",
   [junit4]   1>            "127.0.0.1:41133_solr",
   [junit4]   1>            "127.0.0.1:42161_solr"],
   [junit4]   1>          "nodeNameVsTimeRemoved":{}}
   [junit4]   1>   /autoscaling/events (1)
   [junit4]   1>    /autoscaling/events/.auto_add_replicas (0)
   [junit4]   1>  /autoscaling.json (0)
   [junit4]   1>  DATA:
   [junit4]   1>      {
   [junit4]   1>        "cluster-preferences":[{
   [junit4]   1>            "minimize":"cores",
   [junit4]   1>            "precision":1}],
   [junit4]   1>        "triggers":{".auto_add_replicas":{
   [junit4]   1>            "name":".auto_add_replicas",
   [junit4]   1>            "event":"nodeLost",
   [junit4]   1>            "waitFor":30,
   [junit4]   1>            "actions":[
   [junit4]   1>              {
   [junit4]   1>                "name":"auto_add_replicas_plan",
   [junit4]   1>                "class":"solr.AutoAddReplicasPlanAction"},
   [junit4]   1>              {
   [junit4]   1>                "name":"execute_plan",
   [junit4]   1>                "class":"solr.ExecutePlanAction"}],
   [junit4]   1>            "enabled":true}},
   [junit4]   1>        "listeners":{".auto_add_replicas.system":{
   [junit4]   1>            "beforeAction":[],
   [junit4]   1>            "afterAction":[],
   [junit4]   1>            "trigger":".auto_add_replicas",
   [junit4]   1>            "stage":[
   [junit4]   1>              "STARTED",
   [junit4]   1>              "ABORTED",
   [junit4]   1>              "SUCCEEDED",
   [junit4]   1>              "FAILED",
   [junit4]   1>              "BEFORE_ACTION",
   [junit4]   1>              "AFTER_ACTION",
   [junit4]   1>              "IGNORED"],
   [junit4]   1>            "class":"org.apache.solr.cloud.autoscaling.SystemLogListener"}}}
   [junit4]   1>  /clusterprops.json (0)
   [junit4]   1>  DATA:
   [junit4]   1>      {'urlScheme':'https'}
   [junit4]   1> 
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): {}, docValues:{}, maxPointsInLeafNode=560, maxMBSortInHeap=6.743603304200372, sim=RandomSimilarity(queryNorm=false): {}, locale=rn, timezone=Singapore
   [junit4]   2> NOTE: Linux 4.10.0-37-generic amd64/Oracle Corporation 9.0.1 (64-bit)/cpus=8,threads=1,free=247757576,total=536870912
   [junit4]   2> NOTE: All tests run in this JVM: [CastingIntValueStreamTest, BooleanFieldsTest, ConstantValueTest, GTEFunctionTest, LegacyFacetSortingTest, FloatFieldsTest, TopFunctionTest, CastingLongValueTest, RangeFacetTest]
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=RangeFacetTest -Dtests.seed=53A8356709A986C4 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=rn -Dtests.timezone=Singapore -Dtests.asserts=true -Dtests.file.encoding=ISO-8859-1
   [junit4] ERROR   0.00s J2 | RangeFacetTest (suite) <<<
   [junit4]    > Throwable #1: java.lang.AssertionError: There are still nodes recoverying - waited for 90 seconds
   [junit4]    > 	at __randomizedtesting.SeedInfo.seed([53A8356709A986C4]:0)
   [junit4]    > 	at org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:185)
   [junit4]    > 	at org.apache.solr.analytics.SolrAnalyticsTestCase.setupCollection(SolrAnalyticsTestCase.java:63)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
   [junit4]    > 	at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
   [junit4]    > 	at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
   [junit4]    > 	at java.base/java.lang.reflect.Method.invoke(Method.java:564)
   [junit4]    > 	at java.base/java.lang.Thread.run(Thread.java:844)
   [junit4] Completed [74/78 (1!)] on J2 in 127.74s, 0 tests, 1 failure <<< FAILURES!

[...truncated 37087 lines...]