Return-Path: X-Original-To: archive-asf-public-internal@cust-asf2.ponee.io Delivered-To: archive-asf-public-internal@cust-asf2.ponee.io Received: from cust-asf.ponee.io (cust-asf.ponee.io [163.172.22.183]) by cust-asf2.ponee.io (Postfix) with ESMTP id 5CEE0200CAE for ; Wed, 21 Jun 2017 20:26:02 +0200 (CEST) Received: by cust-asf.ponee.io (Postfix) id 5AB98160BD5; Wed, 21 Jun 2017 18:26:02 +0000 (UTC) Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by cust-asf.ponee.io (Postfix) with SMTP id 036DE160BD0 for ; Wed, 21 Jun 2017 20:25:59 +0200 (CEST) Received: (qmail 16621 invoked by uid 500); 21 Jun 2017 18:25:58 -0000 Mailing-List: contact dev-help@lucene.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@lucene.apache.org Delivered-To: mailing list dev@lucene.apache.org Received: (qmail 16611 invoked by uid 99); 21 Jun 2017 18:25:58 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd4-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 21 Jun 2017 18:25:58 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd4-us-west.apache.org (ASF Mail Server at spamd4-us-west.apache.org) with ESMTP id 02419C00A9 for ; Wed, 21 Jun 2017 18:25:58 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd4-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -0.3 X-Spam-Level: X-Spam-Status: No, score=-0.3 tagged_above=-999 required=6.31 tests=[KAM_BADIPHTTP=2, RCVD_IN_DNSWL_MED=-2.3, SPF_PASS=-0.001, WEIRD_PORT=0.001] autolearn=disabled Received: from mx1-lw-us.apache.org ([10.40.0.8]) by localhost (spamd4-us-west.apache.org [10.40.0.11]) (amavisd-new, port 10024) with ESMTP id qhfZwz9g7zHw for ; Wed, 21 Jun 2017 18:25:42 +0000 (UTC) Received: from serv1.sd-datasolutions.de (serv1.sd-datasolutions.de [88.99.242.108]) by mx1-lw-us.apache.org (ASF Mail Server at mx1-lw-us.apache.org) with ESMTPS id 176735F46F for ; Wed, 21 Jun 2017 18:25:41 +0000 (UTC) Received: from serv1 (ip6-localhost [IPv6:::1]) by serv1.sd-datasolutions.de (Postfix) with ESMTP id 15E4710800CC for ; Wed, 21 Jun 2017 18:25:41 +0000 (UTC) Date: Wed, 21 Jun 2017 18:24:25 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org Message-ID: <23935352.113.1498069541090.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS-EA] Lucene-Solr-master-Linux (32bit/jdk-9-ea+173) - Build # 19926 - Unstable! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_112_931183440.1498069541044" X-Jenkins-Job: Lucene-Solr-master-Linux X-Jenkins-Result: UNSTABLE X-Priority: 5 (Low) archived-at: Wed, 21 Jun 2017 18:26:02 -0000 ------=_Part_112_931183440.1498069541044 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/19926/ Java: 32bit/jdk-9-ea+173 -server -XX:+UseG1GC 8 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CdcrVersionReplica= tionTest Error Message: 2 threads leaked from SUITE scope at org.apache.solr.cloud.CdcrVersionRepli= cationTest: 1) Thread[id=3D13912, name=3Dcdcr-update-log-synchronizer-6= 406-thread-1, state=3DWAITING, group=3DTGRP-CdcrVersionReplicationTest] = at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) = at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockSupport.= java:194) at java.base@9-ea/java.util.concurrent.locks.AbstractQueu= edSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) = at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) at jav= a.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQue= ue.take(ScheduledThreadPoolExecutor.java:848) at java.base@9-ea/jav= a.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1086) = at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker= (ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurre= nt.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) at ja= va.base@9-ea/java.lang.Thread.run(Thread.java:844) 2) Thread[id=3D13900,= name=3Dcdcr-update-log-synchronizer-6400-thread-1, state=3DWAITING, group= =3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.internal.= misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurr= ent.locks.LockSupport.park(LockSupport.java:194) at java.base@9-ea/= java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await= (AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.= concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThrea= dPoolExecutor.java:1119) at java.base@9-ea/java.util.concurrent.Sch= eduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.= java:848) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor= .getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/java.util.= concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1146) = at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.run(Thr= eadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Th= read.java:844) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: 2 threads leaked from S= UITE scope at org.apache.solr.cloud.CdcrVersionReplicationTest:=20 1) Thread[id=3D13912, name=3Dcdcr-update-log-synchronizer-6406-thread-1,= state=3DWAITING, group=3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockS= upport.java:194) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchron= izer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:848) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(T= hreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker= (ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.ru= n(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 2) Thread[id=3D13900, name=3Dcdcr-update-log-synchronizer-6400-thread-1,= state=3DWAITING, group=3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockS= upport.java:194) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchron= izer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:848) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(T= hreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker= (ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.ru= n(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C]:0) FAILED: junit.framework.TestSuite.org.apache.solr.cloud.CdcrVersionReplica= tionTest Error Message: There are still zombie threads that couldn't be terminated: 1) Thread[id= =3D13912, name=3Dcdcr-update-log-synchronizer-6406-thread-1, state=3DWAITIN= G, group=3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.i= nternal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util= .concurrent.locks.LockSupport.park(LockSupport.java:194) at java.ba= se@9-ea/java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObje= ct.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/ja= va.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(Schedu= ledThreadPoolExecutor.java:1119) at java.base@9-ea/java.util.concur= rent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolE= xecutor.java:848) at java.base@9-ea/java.util.concurrent.ThreadPool= Executor.getTask(ThreadPoolExecutor.java:1086) at java.base@9-ea/ja= va.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:114= 6) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker= .run(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Threa= d.run(Thread.java:844) 2) Thread[id=3D13900, name=3Dcdcr-update-log-sync= hronizer-6400-thread-1, state=3DWAITING, group=3DTGRP-CdcrVersionReplicatio= nTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Metho= d) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(Lo= ckSupport.java:194) at java.base@9-ea/java.util.concurrent.locks.Ab= stractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.j= ava:2062) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoo= lExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) = at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$Dela= yedWorkQueue.take(ScheduledThreadPoolExecutor.java:848) at java.bas= e@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.j= ava:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor= .runWorker(ThreadPoolExecutor.java:1146) at java.base@9-ea/java.uti= l.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:635) = at java.base@9-ea/java.lang.Thread.run(Thread.java:844) Stack Trace: com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie = threads that couldn't be terminated: 1) Thread[id=3D13912, name=3Dcdcr-update-log-synchronizer-6406-thread-1,= state=3DWAITING, group=3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockS= upport.java:194) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchron= izer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:848) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(T= hreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker= (ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.ru= n(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) 2) Thread[id=3D13900, name=3Dcdcr-update-log-synchronizer-6400-thread-1,= state=3DWAITING, group=3DTGRP-CdcrVersionReplicationTest] at java.base@9-ea/jdk.internal.misc.Unsafe.park(Native Method) at java.base@9-ea/java.util.concurrent.locks.LockSupport.park(LockS= upport.java:194) at java.base@9-ea/java.util.concurrent.locks.AbstractQueuedSynchron= izer$ConditionObject.await(AbstractQueuedSynchronizer.java:2062) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1119) at java.base@9-ea/java.util.concurrent.ScheduledThreadPoolExecutor$= DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:848) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.getTask(T= hreadPoolExecutor.java:1086) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor.runWorker= (ThreadPoolExecutor.java:1146) at java.base@9-ea/java.util.concurrent.ThreadPoolExecutor$Worker.ru= n(ThreadPoolExecutor.java:635) at java.base@9-ea/java.lang.Thread.run(Thread.java:844) =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C]:0) FAILED: org.apache.solr.cloud.ClusterStateUpdateTest.testCoreRegistration Error Message: expected: but was: Stack Trace: org.junit.ComparisonFailure: expected: but w= as: =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:9B2AED3B4C1E6059]= :0) =09at org.junit.Assert.assertEquals(Assert.java:125) =09at org.junit.Assert.assertEquals(Assert.java:147) =09at org.apache.solr.cloud.ClusterStateUpdateTest.testCoreRegistration(Clu= sterStateUpdateTest.java:104) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:943) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.CollectionsAPISolrJTest.testClusterProp Error Message: Expecting legacyCloud to false as default expected: but was: Stack Trace: java.lang.AssertionError: Expecting legacyCloud to false as default expecte= d: but was: =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:848935D1382AE84B]= :0) =09at org.junit.Assert.fail(Assert.java:93) =09at org.junit.Assert.failNotEquals(Assert.java:647) =09at org.junit.Assert.assertEquals(Assert.java:128) =09at org.apache.solr.cloud.CollectionsAPISolrJTest.testClusterProp(Collect= ionsAPISolrJTest.java:272) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:943) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.LeaderElectionIntegrationTest.testSimpleSlic= eLeaderElection Error Message: Expected to see nodes come back collection1 null Live Nodes: [127.0.0.1:465= 75_solr, 127.0.0.1:46153_solr, 127.0.0.1:39859_solr] Last available state: = DocCollection(collection1//collections/collection1/state.json/17)=3D{ "pu= llReplicas":"0", "replicationFactor":"1", "shards":{ "shard1":{ = "range":"80000000-ffffffff", "state":"active", "replicas":{ = "core_node1":{ "core":"collection1_shard1_replica_n1", = "base_url":"http://127.0.0.1:39859/solr", "node_name":"12= 7.0.0.1:39859_solr", "state":"active", "type":"NRT"}, = "core_node3":{ "core":"collection1_shard1_replica_n2", = "base_url":"http://127.0.0.1:33359/solr", "node_name":"127= .0.0.1:33359_solr", "state":"down", "type":"NRT"}, = "core_node4":{ "core":"collection1_shard1_replica_n3", = "base_url":"http://127.0.0.1:39697/solr", "node_name":"127.0.= 0.1:39697_solr", "state":"down", "type":"NRT"}, = "core_node5":{ "core":"collection1_shard1_replica_n4", = "base_url":"http://127.0.0.1:42803/solr", "node_name":"127.0.0.1= :42803_solr", "state":"down", "type":"NRT"}, "c= ore_node6":{ "core":"collection1_shard1_replica_n5", "b= ase_url":"http://127.0.0.1:46575/solr", "node_name":"127.0.0.1:46= 575_solr", "state":"active", "type":"NRT", "l= eader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":= "active", "replicas":{"core_node2":{ "core":"collection1_sh= ard2_replica_n1", "base_url":"http://127.0.0.1:46153/solr", = "node_name":"127.0.0.1:46153_solr", "state":"active", = "type":"NRT", "leader":"true"}}}}, "router":{"name":"compos= iteId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false", "nrtRepli= cas":"1", "tlogReplicas":"0"} Stack Trace: java.lang.AssertionError: Expected to see nodes come back collection1 null Live Nodes: [127.0.0.1:46575_solr, 127.0.0.1:46153_solr, 127.0.0.1:39859_so= lr] Last available state: DocCollection(collection1//collections/collection1/st= ate.json/17)=3D{ "pullReplicas":"0", "replicationFactor":"1", "shards":{ "shard1":{ "range":"80000000-ffffffff", "state":"active", "replicas":{ "core_node1":{ "core":"collection1_shard1_replica_n1", "base_url":"http://127.0.0.1:39859/solr", "node_name":"127.0.0.1:39859_solr", "state":"active", "type":"NRT"}, "core_node3":{ "core":"collection1_shard1_replica_n2", "base_url":"http://127.0.0.1:33359/solr", "node_name":"127.0.0.1:33359_solr", "state":"down", "type":"NRT"}, "core_node4":{ "core":"collection1_shard1_replica_n3", "base_url":"http://127.0.0.1:39697/solr", "node_name":"127.0.0.1:39697_solr", "state":"down", "type":"NRT"}, "core_node5":{ "core":"collection1_shard1_replica_n4", "base_url":"http://127.0.0.1:42803/solr", "node_name":"127.0.0.1:42803_solr", "state":"down", "type":"NRT"}, "core_node6":{ "core":"collection1_shard1_replica_n5", "base_url":"http://127.0.0.1:46575/solr", "node_name":"127.0.0.1:46575_solr", "state":"active", "type":"NRT", "leader":"true"}}}, "shard2":{ "range":"0-7fffffff", "state":"active", "replicas":{"core_node2":{ "core":"collection1_shard2_replica_n1", "base_url":"http://127.0.0.1:46153/solr", "node_name":"127.0.0.1:46153_solr", "state":"active", "type":"NRT", "leader":"true"}}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"1", "autoAddReplicas":"false", "nrtReplicas":"1", "tlogReplicas":"0"} =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:7B9546DA761BF28B]= :0) =09at org.junit.Assert.fail(Assert.java:93) =09at org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCas= e.java:269) =09at org.apache.solr.cloud.LeaderElectionIntegrationTest.testSimpleSliceLe= aderElection(LeaderElectionIntegrationTest.java:109) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:943) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.ShardSplitTest.testSplitWithChaosMonkey Error Message: shard2 is not consistent. Got 38 from http://127.0.0.1:37009/collection1_s= hard2_replica_n0 (previous client) and got 76 from http://127.0.0.1:32867/c= ollection1_shard2_replica_n1 Stack Trace: java.lang.AssertionError: shard2 is not consistent. Got 38 from http://127= .0.0.1:37009/collection1_shard2_replica_n0 (previous client) and got 76 fro= m http://127.0.0.1:32867/collection1_shard2_replica_n1 =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:AE8658457462C5E8]= :0) =09at org.junit.Assert.fail(Assert.java:93) =09at org.apache.solr.cloud.AbstractFullDistribZkTestBase.checkShardConsist= ency(AbstractFullDistribZkTestBase.java:1319) =09at org.apache.solr.cloud.ShardSplitTest.testSplitWithChaosMonkey(ShardSp= litTest.java:474) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:943) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= FixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= Statement.evaluate(BaseDistributedSearchTestCase.java:960) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test Error Message: Stack Trace: java.lang.NullPointerException =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:ADF5B44E9B980394]= :0) =09at org.apache.solr.cloud.UnloadDistributedZkTest.testCoreUnloadAndLeader= s(UnloadDistributedZkTest.java:171) =09at org.apache.solr.cloud.UnloadDistributedZkTest.test(UnloadDistributedZ= kTest.java:68) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:943) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= FixedStatement.callStatement(BaseDistributedSearchTestCase.java:985) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= Statement.evaluate(BaseDistributedSearchTestCase.java:960) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) FAILED: org.apache.solr.ltr.TestLTROnSolrCloud.testSimpleQuery Error Message: Path not found: /responseHeader/status Stack Trace: java.lang.RuntimeException: Path not found: /responseHeader/status =09at __randomizedtesting.SeedInfo.seed([DB6C43B805DBF997:AE6183A415C13F42]= :0) =09at org.apache.solr.util.RestTestBase.assertJPut(RestTestBase.java:329) =09at org.apache.solr.util.RestTestBase.assertJPut(RestTestBase.java:271) =09at org.apache.solr.ltr.TestRerankBase.loadFeature(TestRerankBase.java:28= 6) =09at org.apache.solr.ltr.TestLTROnSolrCloud.loadModelsAndFeatures(TestLTRO= nSolrCloud.java:184) =09at org.apache.solr.ltr.TestLTROnSolrCloud.setupSolrCluster(TestLTROnSolr= Cloud.java:138) =09at org.apache.solr.ltr.TestLTROnSolrCloud.setUp(TestLTROnSolrCloud.java:= 58) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Nativ= e Method) =09at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(Native= MethodAccessorImpl.java:62) =09at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(De= legatingMethodAccessorImpl.java:43) =09at java.base/java.lang.reflect.Method.invoke(Method.java:564) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1713) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:941) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:957) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:817) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:468) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:916) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:802) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:852) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:863) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:368) =09at java.base/java.lang.Thread.run(Thread.java:844) Build Log: [...truncated 11201 lines...] [junit4] Suite: org.apache.solr.cloud.ClusterStateUpdateTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-mast= er-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.ClusterStateUpdateTes= t_25A18B9435646E6C-001/init-core-data-001 [junit4] 2> 236020 WARN (SUITE-ClusterStateUpdateTest-seed#[25A18B943= 5646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpe= ns=3D9 numCloses=3D9 [junit4] 2> 236021 INFO (SUITE-ClusterStateUpdateTest-seed#[25A18B943= 5646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields [junit4] 2> 236021 INFO (SUITE-ClusterStateUpdateTest-seed#[25A18B943= 5646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clie= ntAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=3D"", ssl=3D0= .0/0.0, value=3D0.0/0.0, clientAuth=3D0.0/0.0) [junit4] 2> 236023 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testC= oreRegistration [junit4] 2> 236023 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.c.MiniSolrCloudCluster Starting = cluster of 3 servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/so= lr/build/solr-core/test/J1/temp/solr.cloud.ClusterStateUpdateTest_25A18B943= 5646E6C-001/tempDir-001 [junit4] 2> 236023 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST = SERVER [junit4] 2> 236024 INFO (Thread-603) [ ] o.a.s.c.ZkTestServer clie= nt port:0.0.0.0/0.0.0.0:0 [junit4] 2> 236024 INFO (Thread-603) [ ] o.a.s.c.ZkTestServer Star= ting server [junit4] 2> 236028 ERROR (Thread-603) [ ] o.a.z.s.ZooKeeperServer Z= KShutdownHandler is not registered, so ZooKeeper server won't take any acti= on on ERROR or SHUTDOWN server state changes [junit4] 2> 236124 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.c.ZkTestServer start zk server o= n port:33729 [junit4] 2> 236129 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 236129 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 236129 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 236130 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@948764{/solr,null,AV= AILABLE} [junit4] 2> 236130 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@ed603b{/solr,null,AV= AILABLE} [junit4] 2> 236130 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@6f452c{/solr,null,AV= AILABLE} [junit4] 2> 236131 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@1ba921a{SSL,[ssl, http/1.1]}{127.= 0.0.1:33039} [junit4] 2> 236131 INFO (jetty-launcher-508-thread-1) [ ] o.e.j.s.= Server Started @238691ms [junit4] 2> 236131 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3303= 9} [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@16b5b8e{SSL,[ssl, http/1.1]}{127.= 0.0.1:36919} [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.e.j.s.= Server Started @238695ms [junit4] 2> 236135 ERROR (jetty-launcher-508-thread-1) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3691= 9} [junit4] 2> 236135 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 236135 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 236135 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 236135 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:00.796570= Z [junit4] 2> 236135 ERROR (jetty-launcher-508-thread-2) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 236135 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:00.796742= Z [junit4] 2> 236135 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@bf8362{SSL,[ssl, http/1.1]}{127.0= .0.1:36351} [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.e.j.s.= Server Started @238696ms [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3635= 1} [junit4] 2> 236136 ERROR (jetty-launcher-508-thread-3) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 236136 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:00.797446= Z [junit4] 2> 236148 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 236148 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 236152 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 236153 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:33729/solr [junit4] 2> 236154 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:33729/solr [junit4] 2> 236165 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:33729/solr [junit4] 2> 236171 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 236171 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 236171 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= OverseerElectionContext I am going to be the leader 127.0.0.1:33039_solr [junit4] 2> 236172 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= Overseer Overseer (id=3D98177384492957702-127.0.0.1:33039_solr-n_0000000000= ) starting [junit4] 2> 236172 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36351= _solr [junit4] 2> 236172 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 236172 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 236173 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 236176 INFO (zkCallback-526-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 236178 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:33039= _solr [junit4] 2> 236177 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36919= _solr [junit4] 2> 236180 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 236180 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 236180 INFO (zkCallback-526-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (3) [junit4] 2> 236231 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_33039.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236234 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_33039.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236234 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_33039.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236234 INFO (jetty-launcher-508-thread-1) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.clou= d.ClusterStateUpdateTest_25A18B9435646E6C-001/tempDir-001/node1/. [junit4] 2> 236240 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36351.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236243 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36351.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236243 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36351.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236243 INFO (jetty-launcher-508-thread-3) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.clou= d.ClusterStateUpdateTest_25A18B9435646E6C-001/tempDir-001/node3/. [junit4] 2> 236259 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36919.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236263 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36919.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236263 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36919.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 236264 INFO (jetty-launcher-508-thread-2) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.clou= d.ClusterStateUpdateTest_25A18B9435646E6C-001/tempDir-001/node2/. [junit4] 2> 236282 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.c.c.ZkStateReader Updated live n= odes from ZooKeeper... (0) -> (3) [junit4] 2> 236282 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvid= er Cluster at 127.0.0.1:33729/solr ready [junit4] 2> 236305 INFO (qtp7242080-2868) [ ] o.a.s.h.a.Collection= sHandler Invoked Collection Action :create with params pullReplicas=3D0&rep= licationFactor=3D1&name=3Dtestcore&nrtReplicas=3D1&action=3DCREATE&numShard= s=3D1&tlogReplicas=3D0&createNodeSet=3D127.0.0.1:33039_solr&wt=3Djavabin&ve= rsion=3D2 and sendToOCPQueue=3Dtrue [junit4] 2> 236307 INFO (OverseerThreadFactory-1323-thread-1) [ ] = o.a.s.c.CreateCollectionCmd Create collection testcore [junit4] 2> 236307 INFO (OverseerThreadFactory-1323-thread-1) [ ] = o.a.s.c.CreateCollectionCmd Only one config set found in zk - using it:conf [junit4] 2> 236410 INFO (OverseerStateUpdate-98177384492957702-127.0.= 0.1:33039_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"testcore", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"testcore_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:33039/solr", [junit4] 2> "type":"NRT"}=20 [junit4] 2> 236632 INFO (qtp27251759-2866) [ ] o.a.s.h.a.CoreAdmin= Operation core create command qt=3D/admin/cores&coreNodeName=3Dcore_node1&c= ollection.configName=3Dconf&newCollection=3Dtrue&name=3Dtestcore_shard1_rep= lica_n1&action=3DCREATE&numShards=3D1&collection=3Dtestcore&shard=3Dshard1&= wt=3Djavabin&version=3D2&replicaType=3DNRT [junit4] 2> 236632 INFO (qtp27251759-2866) [ ] o.a.s.c.TransientSo= lrCoreCacheDefault Allocating transient cache for 2147483647 transient core= s [junit4] 2> 236734 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 236734 INFO (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 237638 INFO (qtp27251759-2866) [ ] o.a.s.c.SolrConfig = Using Lucene MatchVersion: 7.0.0 [junit4] 2> 237642 INFO (qtp27251759-2866) [ ] o.a.s.s.IndexSchema= [testcore_shard1_replica_n1] Schema name=3Dminimal [junit4] 2> 237643 INFO (qtp27251759-2866) [ ] o.a.s.s.IndexSchema= Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 237643 INFO (qtp27251759-2866) [ ] o.a.s.c.CoreContain= er Creating SolrCore 'testcore_shard1_replica_n1' using configuration from = collection testcore, trusted=3Dtrue [junit4] 2> 237644 INFO (qtp27251759-2866) [ ] o.a.s.m.r.SolrJmxRe= porter JMX monitoring for 'solr_33039.solr.core.testcore.shard1.replica_n1'= (registry 'solr.core.testcore.shard1.replica_n1') enabled at server: com.s= un.jmx.mbeanserver.JmxMBeanServer@882072 [junit4] 2> 237644 INFO (qtp27251759-2866) [ ] o.a.s.c.SolrCore so= lr.RecoveryStrategy.Builder [junit4] 2> 237644 INFO (qtp27251759-2866) [ ] o.a.s.c.SolrCore [[= testcore_shard1_replica_n1] ] Opening new SolrCore at [/home/jenkins/worksp= ace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.cloud.C= lusterStateUpdateTest_25A18B9435646E6C-001/tempDir-001/node1/testcore_shard= 1_replica_n1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/= solr/build/solr-core/test/J1/temp/solr.cloud.ClusterStateUpdateTest_25A18B9= 435646E6C-001/tempDir-001/node1/./testcore_shard1_replica_n1/data/] [junit4] 2> 237679 INFO (qtp27251759-2866) [ ] o.a.s.u.UpdateHandl= er Using UpdateLog implementation: org.apache.solr.update.UpdateLog [junit4] 2> 237679 INFO (qtp27251759-2866) [ ] o.a.s.u.UpdateLog I= nitializing UpdateLog: dataDir=3Dnull defaultSyncLevel=3DFLUSH numRecordsTo= Keep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets=3D65536 [junit4] 2> 237680 INFO (qtp27251759-2866) [ ] o.a.s.u.CommitTrack= er Hard AutoCommit: disabled [junit4] 2> 237680 INFO (qtp27251759-2866) [ ] o.a.s.u.CommitTrack= er Soft AutoCommit: disabled [junit4] 2> 237681 INFO (qtp27251759-2866) [ ] o.a.s.s.SolrIndexSe= archer Opening [Searcher@15cfb73[testcore_shard1_replica_n1] main] [junit4] 2> 237682 INFO (qtp27251759-2866) [ ] o.a.s.r.ManagedReso= urceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf [junit4] 2> 237682 INFO (qtp27251759-2866) [ ] o.a.s.r.ManagedReso= urceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO= :path=3D/configs/conf [junit4] 2> 237683 INFO (qtp27251759-2866) [ ] o.a.s.h.Replication= Handler Commits will be reserved for 10000 [junit4] 2> 237684 INFO (searcherExecutor-1330-thread-1) [ ] o.a.s= .c.SolrCore [testcore_shard1_replica_n1] Registered new searcher Searcher@1= 5cfb73[testcore_shard1_replica_n1] main{ExitableDirectoryReader(Uninverting= DirectoryReader())} [junit4] 2> 237684 INFO (qtp27251759-2866) [ ] o.a.s.u.UpdateLog C= ould not find max version in index or recent updates, using new clock 15708= 38153626910720 [junit4] 2> 237687 INFO (qtp27251759-2866) [ ] o.a.s.c.ShardLeader= ElectionContext Enough replicas found to continue. [junit4] 2> 237687 INFO (qtp27251759-2866) [ ] o.a.s.c.ShardLeader= ElectionContext I may be the new leader - try and sync [junit4] 2> 237687 INFO (qtp27251759-2866) [ ] o.a.s.c.ShardLeader= ElectionContext Found all replicas participating in election, clear LIR [junit4] 2> 237688 INFO (qtp27251759-2866) [ ] o.a.s.c.ShardLeader= ElectionContext I am the new leader: https://127.0.0.1:33039/solr/testcore_= shard1_replica_n1/ shard1 [junit4] 2> 237789 INFO (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 237789 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 237839 WARN (qtp27251759-2866) [ ] o.a.s.c.ZkControlle= r Skipping recovery according to sys prop solrcloud.skip.autorecovery [junit4] 2> 237840 INFO (qtp27251759-2866) [ ] o.a.s.s.HttpSolrCal= l [admin] webapp=3Dnull path=3D/admin/cores params=3D{qt=3D/admin/cores&cor= eNodeName=3Dcore_node1&collection.configName=3Dconf&newCollection=3Dtrue&na= me=3Dtestcore_shard1_replica_n1&action=3DCREATE&numShards=3D1&collection=3D= testcore&shard=3Dshard1&wt=3Djavabin&version=3D2&replicaType=3DNRT} status= =3D0 QTime=3D1209 [junit4] 2> 237842 INFO (qtp7242080-2868) [ ] o.a.s.h.a.Collection= sHandler Wait for new collection to be active for at most 30 seconds. Check= all shard replicas [junit4] 2> 237941 INFO (zkCallback-520-thread-1) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 237941 INFO (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/testcore/state.json] for collection [test= core] has occurred - updating... (live nodes size: [3]) [junit4] 2> 238308 INFO (OverseerCollectionConfigSetProcessor-9817738= 4492957702-127.0.0.1:33039_solr-n_0000000000) [ ] o.a.s.c.OverseerTaskQu= eue Response ZK path: /overseer/collection-queue-work/qnr-0000000000 doesn'= t exist. Requestor may have disconnected from ZooKeeper [junit4] 2> 238843 INFO (qtp7242080-2868) [ ] o.a.s.s.HttpSolrCall= [admin] webapp=3Dnull path=3D/admin/collections params=3D{pullReplicas=3D0= &replicationFactor=3D1&name=3Dtestcore&nrtReplicas=3D1&action=3DCREATE&numS= hards=3D1&tlogReplicas=3D0&createNodeSet=3D127.0.0.1:33039_solr&wt=3Djavabi= n&version=3D2} status=3D0 QTime=3D2537 [junit4] 2> 238844 INFO (TEST-ClusterStateUpdateTest.testCoreRegistra= tion-seed#[25A18B9435646E6C]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testCor= eRegistration [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=3DClusterStateU= pdateTest -Dtests.method=3DtestCoreRegistration -Dtests.seed=3D25A18B943564= 6E6C -Dtests.multiplier=3D3 -Dtests.slow=3Dtrue -Dtests.locale=3Drm-CH -Dte= sts.timezone=3DAmerica/Metlakatla -Dtests.asserts=3Dtrue -Dtests.file.encod= ing=3DUTF-8 [junit4] FAILURE 2.82s J1 | ClusterStateUpdateTest.testCoreRegistration = <<< [junit4] > Throwable #1: org.junit.ComparisonFailure: expected: but was: [junit4] > =09at __randomizedtesting.SeedInfo.seed([25A18B9435646E6C:= 9B2AED3B4C1E6059]:0) [junit4] > =09at org.apache.solr.cloud.ClusterStateUpdateTest.testCor= eRegistration(ClusterStateUpdateTest.java:104) [junit4] > =09at java.base/jdk.internal.reflect.NativeMethodAccessorI= mpl.invoke0(Native Method) [junit4] > =09at java.base/jdk.internal.reflect.NativeMethodAccessorI= mpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > =09at java.base/jdk.internal.reflect.DelegatingMethodAcces= sorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > =09at java.base/java.lang.reflect.Method.invoke(Method.jav= a:564) [junit4] > =09at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 238847 INFO (jetty-closer-509-thread-1) [ ] o.e.j.s.Ab= stractConnector Stopped ServerConnector@1ba921a{SSL,[ssl, http/1.1]}{127.0.= 0.1:0} [junit4] 2> 238847 INFO (jetty-closer-509-thread-2) [ ] o.e.j.s.Ab= stractConnector Stopped ServerConnector@bf8362{SSL,[ssl, http/1.1]}{127.0.0= .1:0} [junit4] 2> 238847 INFO (jetty-closer-509-thread-1) [ ] o.a.s.c.Co= reContainer Shutting down CoreContainer instance=3D29625386 [junit4] 2> 238848 INFO (jetty-closer-509-thread-2) [ ] o.a.s.c.Co= reContainer Shutting down CoreContainer instance=3D27465544 [junit4] 2> 238847 INFO (jetty-closer-509-thread-3) [ ] o.e.j.s.Ab= stractConnector Stopped ServerConnector@16b5b8e{SSL,[ssl, http/1.1]}{127.0.= 0.1:0} [junit4] 2> 238848 INFO (jetty-closer-509-thread-3) [ ] o.a.s.c.Co= reContainer Shutting down CoreContainer instance=3D15665311 [junit4] 2> 238848 INFO (jetty-closer-509-thread-1) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnu= ll [junit4] 2> 238848 INFO (jetty-closer-509-thread-3) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnu= ll [junit4] 2> 238849 INFO (jetty-closer-509-thread-1) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnul= l [junit4] 2> 238849 INFO (jetty-closer-509-thread-3) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnul= l [junit4] 2> 238849 INFO (jetty-closer-509-thread-2) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnu= ll [junit4] 2> 238850 INFO (jetty-closer-509-thread-1) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dn= ull [junit4] 2> 238850 INFO (jetty-closer-509-thread-3) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dn= ull [junit4] 2> 238850 INFO (jetty-closer-509-thread-3) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.cluster, tag= =3Dnull [junit4] 2> 238850 INFO (jetty-closer-509-thread-1) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.cluster, tag= =3Dnull [junit4] 2> 238851 INFO (jetty-closer-509-thread-3) [ ] o.a.s.c.Tr= ansientSolrCoreCacheDefault Allocating transient cache for 2147483647 trans= ient cores [junit4] 2> 238851 INFO (coreCloseExecutor-1335-thread-1) [ ] o.a.= s.c.SolrCore [testcore_shard1_replica_n1] CLOSING SolrCore org.apache.solr= .core.SolrCore@15b2774 [junit4] 2> 238851 INFO (jetty-closer-509-thread-2) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnul= l [junit4] 2> 238851 INFO (zkCallback-523-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 238851 INFO (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 238852 INFO (coreCloseExecutor-1335-thread-1) [ ] o.a.= s.m.SolrMetricManager Closing metric reporters for registry=3Dsolr.core.tes= tcore.shard1.replica_n1, tag=3D22751092 [junit4] 2> 238852 INFO (jetty-closer-509-thread-2) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dn= ull [junit4] 2> 238852 INFO (jetty-closer-509-thread-2) [ ] o.a.s.m.So= lrMetricManager Closing metric reporters for registry=3Dsolr.cluster, tag= =3Dnull [junit4] 2> 238852 INFO (jetty-closer-509-thread-2) [ ] o.a.s.c.Tr= ansientSolrCoreCacheDefault Allocating transient cache for 2147483647 trans= ient cores [junit4] 2> 238853 INFO (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (2) -> (1) [junit4] 2> 238853 WARN (zkCallback-523-thread-1) [ ] o.a.s.c.c.Zk= StateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperE= rrorCode =3D Session expired for /live_nodes] [junit4] 2> 238853 INFO (jetty-closer-509-thread-2) [ ] o.e.j.s.h.= ContextHandler Stopped o.e.j.s.ServletContextHandler@948764{/solr,null,UNAV= AILABLE} [junit4] 2> 238854 INFO (coreCloseExecutor-1335-thread-1) [ ] o.a.= s.m.SolrMetricManager Closing metric reporters for registry=3Dsolr.collecti= on.testcore.shard1.leader, tag=3D22751092 [junit4] 2> 238854 INFO (jetty-closer-509-thread-1) [ ] o.a.s.c.Ov= erseer Overseer (id=3D98177384492957702-127.0.0.1:33039_solr-n_0000000000) = closing [junit4] 2> 238854 INFO (OverseerStateUpdate-98177384492957702-127.0.= 0.1:33039_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting = : 127.0.0.1:33039_solr [junit4] 2> 240351 WARN (zkCallback-526-thread-1) [ ] o.a.s.c.c.Zk= StateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperE= rrorCode =3D Session expired for /live_nodes] [junit4] 2> 240352 INFO (jetty-closer-509-thread-3) [ ] o.e.j.s.h.= ContextHandler Stopped o.e.j.s.ServletContextHandler@6f452c{/solr,null,UNAV= AILABLE} [junit4] 2> 240355 WARN (zkCallback-520-thread-2) [ ] o.a.s.c.c.Zk= StateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperE= rrorCode =3D Session expired for /live_nodes] [junit4] 2> 240355 INFO (jetty-closer-509-thread-1) [ ] o.e.j.s.h.= ContextHandler Stopped o.e.j.s.ServletContextHandler@ed603b{/solr,null,UNAV= AILABLE} [junit4] 2> 240356 ERROR (SUITE-ClusterStateUpdateTest-seed#[25A18B943= 5646E6C]-worker) [ ] o.a.z.s.ZooKeeperServer ZKShutdownHandler is not re= gistered, so ZooKeeper server won't take any action on ERROR or SHUTDOWN se= rver state changes [junit4] 2> 240356 INFO (SUITE-ClusterStateUpdateTest-seed#[25A18B943= 5646E6C]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:33729 = 33729 [junit4] 2> 240416 INFO (Thread-603) [ ] o.a.s.c.ZkTestServer conn= ecting to 127.0.0.1:33729 33729 [junit4] 2> 240417 WARN (Thread-603) [ ] o.a.s.c.ZkTestServer Watc= h limit violations:=20 [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2>=20 [junit4] 2> =094=09/solr/aliases.json [junit4] 2> =093=09/solr/security.json [junit4] 2>=20 [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2>=20 [junit4] 2> =095=09/solr/collections/testcore/state.json [junit4] 2> =094=09/solr/clusterstate.json [junit4] 2> =094=09/solr/clusterprops.json [junit4] 2>=20 [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2>=20 [junit4] 2> =094=09/solr/live_nodes [junit4] 2> =094=09/solr/collections [junit4] 2>=20 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/wo= rkspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J1/temp/solr.clo= ud.ClusterStateUpdateTest_25A18B9435646E6C-001 [junit4] 2> Jun 21, 2017 6:00:05 PM com.carrotsearch.randomizedtesting= .ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thre= ad(s). [junit4] 2> NOTE: test params are: codec=3DAsserting(Lucene70): {}, do= cValues:{}, maxPointsInLeafNode=3D315, maxMBSortInHeap=3D6.051725824725412,= sim=3DRandomSimilarity(queryNorm=3Dfalse): {}, locale=3Drm-CH, timezone=3D= America/Metlakatla [junit4] 2> NOTE: Linux 4.10.0-21-generic i386/Oracle Corporation 9-ea= (32-bit)/cpus=3D8,threads=3D1,free=3D161084776,total=3D536870912 [junit4] 2> NOTE: All tests run in this JVM: [DeleteNodeTest, IndexSch= emaTest, TestInitParams, TestRTimerTree, TestRawTransformer, LeaderInitiate= dRecoveryOnCommitTest, TestCoreContainer, TestMacroExpander, Classification= UpdateProcessorIntegrationTest, TestNumericRangeQuery64, AnalyticsQueryTest= , TestCloudNestedDocsSort, UpdateLogTest, UtilsToolTest, TestScoreJoinQPSco= re, SimplePostToolTest, SpellCheckComponentTest, HdfsWriteToMultipleCollect= ionsTest, TestCloudSchemaless, TestLegacyFieldCache, SegmentsInfoRequestHan= dlerTest, CollectionsAPIAsyncDistributedZkTest, SampleTest, TestFieldResour= ce, MoreLikeThisHandlerTest, HttpSolrCallGetCoreTest, SystemInfoHandlerTest= , TestStandardQParsers, HdfsDirectoryFactoryTest, OverseerStatusTest, Direc= tSolrSpellCheckerTest, AutoScalingHandlerTest, CollectionReloadTest, TestDy= namicFieldCollectionResource, QueryParsingTest, TestPerFieldSimilarity, Tes= tEmbeddedSolrServerSchemaAPI, SolrMetricManagerTest, IndexBasedSpellChecker= Test, DistributedFacetPivotSmallTest, TestSolrCloudWithDelegationTokens, Te= stBulkSchemaConcurrent, TestSortByMinMaxFunction, SSLMigrationTest, Cluster= StateUpdateTest] [junit4] Completed [95/725 (1!)] on J1 in 5.41s, 1 test, 1 failure <<< F= AILURES! [...truncated 28 lines...] [junit4] Suite: org.apache.solr.cloud.CollectionsAPISolrJTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-mast= er-Linux/solr/build/solr-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTe= st_25A18B9435646E6C-001/init-core-data-001 [junit4] 2> 248277 WARN (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOp= ens=3D1 numCloses=3D1 [junit4] 2> 248278 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields [junit4] 2> 248278 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and cli= entAuth (true) via: @org.apache.solr.util.RandomizeSSL(reason=3D"", ssl=3D0= .0/0.0, value=3D0.0/0.0, clientAuth=3D0.0/0.0) [junit4] 2> 248279 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4= servers in /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/sol= r-core/test/J2/temp/solr.cloud.CollectionsAPISolrJTest_25A18B9435646E6C-001= /tempDir-001 [junit4] 2> 248279 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 248279 INFO (Thread-532) [ ] o.a.s.c.ZkTestServer clie= nt port:0.0.0.0/0.0.0.0:0 [junit4] 2> 248279 INFO (Thread-532) [ ] o.a.s.c.ZkTestServer Star= ting server [junit4] 2> 248284 ERROR (Thread-532) [ ] o.a.z.s.ZooKeeperServer Z= KShutdownHandler is not registered, so ZooKeeper server won't take any acti= on on ERROR or SHUTDOWN server state changes [junit4] 2> 248379 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:35467 [junit4] 2> 248384 INFO (jetty-launcher-424-thread-1) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 248385 INFO (jetty-launcher-424-thread-2) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 248386 INFO (jetty-launcher-424-thread-3) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 248392 INFO (jetty-launcher-424-thread-4) [ ] o.e.j.s.= Server jetty-9.3.14.v20161028 [junit4] 2> 248397 INFO (jetty-launcher-424-thread-2) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@a89c5e{/solr,null,AV= AILABLE} [junit4] 2> 248397 INFO (jetty-launcher-424-thread-1) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@8e9efc{/solr,null,AV= AILABLE} [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@5e2c61{SSL,[ssl, http/1.1]}{127.0= .0.1:37067} [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.e.j.s.= Server Started @250324ms [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3706= 7} [junit4] 2> 248398 ERROR (jetty-launcher-424-thread-2) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 248398 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:12.425404= Z [junit4] 2> 248398 INFO (jetty-launcher-424-thread-4) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@5d93eb{/solr,null,AV= AILABLE} [junit4] 2> 248398 INFO (jetty-launcher-424-thread-4) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@118829d{SSL,[ssl, http/1.1]}{127.= 0.0.1:36693} [junit4] 2> 248398 INFO (jetty-launcher-424-thread-4) [ ] o.e.j.s.= Server Started @250325ms [junit4] 2> 248398 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3669= 3} [junit4] 2> 248399 ERROR (jetty-launcher-424-thread-4) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 248399 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 248399 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 248399 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 248399 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:12.426175= Z [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@d5127a{SSL,[ssl, http/1.1]}{127.0= .0.1:32909} [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.e.j.s.= Server Started @250327ms [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3290= 9} [junit4] 2> 248401 INFO (jetty-launcher-424-thread-3) [ ] o.e.j.s.= h.ContextHandler Started o.e.j.s.ServletContextHandler@42c940{/solr,null,AV= AILABLE} [junit4] 2> 248401 ERROR (jetty-launcher-424-thread-1) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 248401 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:12.428716= Z [junit4] 2> 248401 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 248401 INFO (jetty-launcher-424-thread-3) [ ] o.e.j.s.= AbstractConnector Started ServerConnector@1723f98{SSL,[ssl, http/1.1]}{127.= 0.0.1:38941} [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.e.j.s.= Server Started @250328ms [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D3894= 1} [junit4] 2> 248402 ERROR (jetty-launcher-424-thread-3) [ ] o.a.s.s.= StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missin= g or incomplete. [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.s.= SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versio= n 7.0.0 [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.s.= SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.s.= SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 248402 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.s.= SolrDispatchFilter |___/\___/_|_| Start time: 2017-06-21T18:00:12.429583= Z [junit4] 2> 248404 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ = ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from = client sessionid 0x15ccbcfcd130001, likely client has closed socket [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOSe= rverCnxn.java:239) [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxnFactory.run= (NIOServerCnxnFactory.java:203) [junit4] 2> =09at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 248405 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 248405 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 248405 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.s.= SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 248406 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:35467/solr [junit4] 2> 248409 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:35467/solr [junit4] 2> 248415 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:35467/solr [junit4] 2> 248418 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= ZkContainer Zookeeper client=3D127.0.0.1:35467/solr [junit4] 2> 248419 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 248422 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= OverseerElectionContext I am going to be the leader 127.0.0.1:37067_solr [junit4] 2> 248423 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= Overseer Overseer (id=3D98177385254551558-127.0.0.1:37067_solr-n_0000000000= ) starting [junit4] 2> 248423 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ = ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from = client sessionid 0x15ccbcfcd13000a, likely client has closed socket [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOSe= rverCnxn.java:239) [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxnFactory.run= (NIOServerCnxnFactory.java:203) [junit4] 2> =09at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 248425 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 248425 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:36693= _solr [junit4] 2> 248426 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 248426 INFO (zkCallback-439-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 248427 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 248428 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 248429 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:38941= _solr [junit4] 2> 248429 INFO (zkCallback-439-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 248429 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 248432 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:37067= _solr [junit4] 2> 248433 INFO (zkCallback-439-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 248433 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 248434 INFO (zkCallback-446-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 248434 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 248434 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= Overseer Overseer (id=3Dnull) closing [junit4] 2> 248438 INFO (zkCallback-446-thread-2) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 248439 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:32909= _solr [junit4] 2> 248439 INFO (zkCallback-434-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 248440 INFO (zkCallback-447-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 248440 INFO (zkCallback-446-thread-2) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 248440 INFO (zkCallback-439-thread-1) [ ] o.a.s.c.c.Zk= StateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 248491 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_38941.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248495 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_38941.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248495 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_38941.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248496 INFO (jetty-launcher-424-thread-3) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.clou= d.CollectionsAPISolrJTest_25A18B9435646E6C-001/tempDir-001/node3/. [junit4] 2> 248513 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_37067.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248516 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_37067.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248516 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_37067.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248516 INFO (jetty-launcher-424-thread-2) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.clou= d.CollectionsAPISolrJTest_25A18B9435646E6C-001/tempDir-001/node2/. [junit4] 2> 248539 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_32909.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248541 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_32909.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248541 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_32909.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248542 INFO (jetty-launcher-424-thread-1) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.clou= d.CollectionsAPISolrJTest_25A18B9435646E6C-001/tempDir-001/node1/. [junit4] 2> 248561 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36693.solr.node' (registry 'solr= .node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248564 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36693.solr.jvm' (registry 'solr.= jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248564 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.m.= r.SolrJmxReporter JMX monitoring for 'solr_36693.solr.jetty' (registry 'sol= r.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@adebe8 [junit4] 2> 248565 INFO (jetty-launcher-424-thread-4) [ ] o.a.s.c.= CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/wor= kspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J2/temp/solr.clou= d.CollectionsAPISolrJTest_25A18B9435646E6C-001/tempDir-001/node4/. [junit4] 2> 248584 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from Zo= oKeeper... (0) -> (4) [junit4] 2> 248584 INFO (SUITE-CollectionsAPISolrJTest-seed#[25A18B94= 35646E6C]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster a= t 127.0.0.1:35467/solr ready [junit4] 2> 248596 INFO (TEST-CollectionsAPISolrJTest.testCreateAndDe= leteAlias-seed#[25A18B9435646E6C]) [ ] o.a.s.SolrTestCaseJ4 ###Starting = testCreateAndDeleteAlias [junit4] 2> 248630 INFO (qtp2120941-2512) [ ] o.a.s.h.a.Collection= sHandler Invoked Collection Action :create with params replicationFactor=3D= 1&collection.configName=3Dconf&name=3DaliasedCollection&nrtReplicas=3D1&act= ion=3DCREATE&numShards=3D1&wt=3Djavabin&version=3D2 and sendToOCPQueue=3Dtr= ue [junit4] 2> 248631 INFO (OverseerThreadFactory-971-thread-1) [ ] o= .a.s.c.CreateCollectionCmd Create collection aliasedCollection [junit4] 2> 248734 INFO (OverseerStateUpdate-98177385254551558-127.0.= 0.1:37067_solr-n_0000000000) [ ] o.a.s.c.o.SliceMutator createReplica() = { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"aliasedCollection", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"aliasedCollection_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"https://127.0.0.1:32909/solr", [junit4] 2> "type":"NRT"}=20 [junit4] 2> 248966 INFO (qtp7184994-2513) [ ] o.a.s.h.a.CoreAdminO= peration core create command qt=3D/admin/cores&coreNodeName=3Dcore_node1&co= llection.configName=3Dconf&newCollection=3Dtrue&name=3DaliasedCollection_sh= ard1_replica_n1&action=3DCREATE&numShards=3D1&collection=3DaliasedCollectio= n&shard=3Dshard1&wt=3Djavabin&version=3D2&replicaType=3DNRT [junit4] 2> 248966 INFO (qtp7184994-2513) [ ] o.a.s.c.TransientSol= rCoreCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 249072 INFO (zkCallback-447-thread-1) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/aliasedCollection/state.json] for collect= ion [aliasedCollection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 249072 INFO (zkCallback-447-thread-2) [ ] o.a.s.c.c.Zk= StateReader A cluster state change: [WatchedEvent state:SyncConnected type:= NodeDataChanged path:/collections/aliasedCollection/state.json] for collect= ion [aliasedCollection] has occurred - updating... (live nodes size: [4]) [junit4] 2> 249972 INFO (qtp7184994-2513) [ ] o.a.s.c.SolrConfig U= sing Lucene MatchVersion: 7.0.0 [junit4] 2> 249977 INFO (qtp7184994-2513) [ ] o.a.s.s.IndexSchema = [aliasedCollection_shard1_replica_n1] Schema name=3Dminimal [junit4] 2> 249979 INFO (qtp7184994-2513) [ ] o.a.s.s.IndexSchema = Loaded schema minimal/1.1 with uniqueid field id [junit4] 2> 249979 INFO (qtp7184994-2513) [ ] o.a.s.c.CoreContaine= r Creating [...truncated too long message...] 2> 10088 INFO (jetty-closer-2-thread-1) [ ] o.a.s.c.CoreContainer Shutt= ing down CoreContainer instance=3D345454 [junit4] 2> 10088 INFO (jetty-closer-2-thread-1) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 10093 INFO (jetty-closer-2-thread-2) [ ] o.e.j.s.Abstr= actConnector Stopped ServerConnector@b78aee{HTTP/1.1,[http/1.1]}{127.0.0.1:= 0} [junit4] 2> 10093 INFO (jetty-closer-2-thread-2) [ ] o.a.s.c.CoreC= ontainer Shutting down CoreContainer instance=3D9148861 [junit4] 2> 10097 INFO (jetty-closer-2-thread-1) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 10102 INFO (jetty-closer-2-thread-2) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 10104 INFO (jetty-closer-2-thread-1) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 10121 INFO (jetty-closer-2-thread-2) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 10126 INFO (jetty-closer-2-thread-2) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 10126 INFO (jetty-closer-2-thread-1) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.cluster, tag=3Dnu= ll [junit4] 2> 10126 INFO (jetty-closer-2-thread-3) [ ] o.e.j.s.Abstr= actConnector Stopped ServerConnector@37b8fb{HTTP/1.1,[http/1.1]}{127.0.0.1:= 0} [junit4] 2> 10130 INFO (jetty-closer-2-thread-3) [ ] o.a.s.c.CoreC= ontainer Shutting down CoreContainer instance=3D20552433 [junit4] 2> 10130 INFO (jetty-closer-2-thread-3) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 10144 INFO (zkCallback-16-thread-1) [ ] o.a.s.c.c.ZkSt= ateReader A cluster state change: [WatchedEvent state:SyncConnected type:No= deDataChanged path:/collections/collection1/state.json] for collection [col= lection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 10144 INFO (zkCallback-16-thread-2) [ ] o.a.s.c.c.ZkSt= ateReader A cluster state change: [WatchedEvent state:SyncConnected type:No= deDataChanged path:/collections/collection1/state.json] for collection [col= lection1] has occurred - updating... (live nodes size: [3]) [junit4] 2> 10156 INFO (jetty-closer-2-thread-3) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 10162 INFO (jetty-closer-2-thread-2) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.cluster, tag=3Dnu= ll [junit4] 2> 10162 INFO (jetty-closer-2-thread-2) [ ] o.a.s.c.Trans= ientSolrCoreCacheDefault Allocating transient cache for 2147483647 transien= t cores [junit4] 2> 10182 INFO (coreCloseExecutor-33-thread-1) [ ] o.a.s.c= .SolrCore [collection1_shard1_replica_n1] CLOSING SolrCore org.apache.solr= .core.SolrCore@108b6b4 [junit4] 2> 10184 INFO (jetty-closer-2-thread-3) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 10184 INFO (jetty-closer-2-thread-2) [ ] o.a.s.c.Overs= eer Overseer (id=3D98177472014450697-127.0.0.1:43883_solr-n_0000000000) clo= sing [junit4] 2> 10185 INFO (OverseerStateUpdate-98177472014450697-127.0.0= .1:43883_solr-n_0000000000) [ ] o.a.s.c.Overseer Overseer Loop exiting := 127.0.0.1:43883_solr [junit4] 2> 10199 INFO (jetty-closer-2-thread-3) [ ] o.a.s.m.SolrM= etricManager Closing metric reporters for registry=3Dsolr.cluster, tag=3Dnu= ll [junit4] 2> 10199 INFO (jetty-closer-2-thread-3) [ ] o.a.s.c.Trans= ientSolrCoreCacheDefault Allocating transient cache for 2147483647 transien= t cores [junit4] 2> 10218 INFO (coreCloseExecutor-33-thread-1) [ ] o.a.s.m= .SolrMetricManager Closing metric reporters for registry=3Dsolr.core.collec= tion1.shard1.replica_n1, tag=3D17348276 [junit4] 2> 10225 INFO (coreCloseExecutor-33-thread-1) [ ] o.a.s.m= .SolrMetricManager Closing metric reporters for registry=3Dsolr.collection.= collection1.shard1.leader, tag=3D17348276 [junit4] 2> 10226 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ = ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from = client sessionid 0x15ccbe4005e0008, likely client has closed socket [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOSe= rverCnxn.java:239) [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxnFactory.run= (NIOServerCnxnFactory.java:203) [junit4] 2> =09at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> 10226 INFO (jetty-closer-2-thread-3) [ ] o.e.j.s.h.Con= textHandler Stopped o.e.j.s.ServletContextHandler@557d58{/solr,null,UNAVAIL= ABLE} [junit4] 2> 10227 INFO (zkCallback-16-thread-1) [ ] o.a.s.c.Overse= erElectionContext I am going to be the leader 127.0.0.1:42323_solr [junit4] 2> 10226 WARN (zkCallback-18-thread-1) [ ] o.a.s.c.c.ZkSt= ateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErr= orCode =3D Session expired for /live_nodes] [junit4] 2> 10227 INFO (zkCallback-16-thread-2) [ ] o.a.s.c.c.ZkSt= ateReader Updated live nodes from ZooKeeper... (3) -> (1) [junit4] 2> 10227 INFO (jetty-closer-2-thread-2) [ ] o.e.j.s.h.Con= textHandler Stopped o.e.j.s.ServletContextHandler@2d875a{/solr,null,UNAVAIL= ABLE} [junit4] 2> 11730 WARN (zkCallback-16-thread-1) [ ] o.a.s.c.c.ZkSt= ateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErr= orCode =3D Session expired for /live_nodes] [junit4] 2> 11730 INFO (jetty-closer-2-thread-1) [ ] o.e.j.s.h.Con= textHandler Stopped o.e.j.s.ServletContextHandler@1f5358{/solr,null,UNAVAIL= ABLE} [junit4] 2> 11731 ERROR (TEST-TestLTROnSolrCloud.testSimpleQuery-seed#= [DB6C43B805DBF997]) [ ] 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> 11731 INFO (TEST-TestLTROnSolrCloud.testSimpleQuery-seed#= [DB6C43B805DBF997]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:367= 67 36767 [junit4] 2> 11763 INFO (Thread-0) [ ] o.a.s.c.ZkTestServer connect= ing to 127.0.0.1:36767 36767 [junit4] 2> 11764 WARN (Thread-0) [ ] o.a.s.c.ZkTestServer Watch l= imit violations:=20 [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2>=20 [junit4] 2> =095=09/solr/aliases.json [junit4] 2> =095=09/solr/clusterprops.json [junit4] 2> =094=09/solr/security.json [junit4] 2>=20 [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2>=20 [junit4] 2> =096=09/solr/collections/collection1/state.json [junit4] 2> =095=09/solr/clusterstate.json [junit4] 2>=20 [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2>=20 [junit4] 2> =095=09/solr/live_nodes [junit4] 2> =095=09/solr/collections [junit4] 2>=20 [junit4] 2> 11764 INFO (TEST-TestLTROnSolrCloud.testSimpleQuery-seed#= [DB6C43B805DBF997]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testSimpleQuery [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=3DTestLTROnSolr= Cloud -Dtests.method=3DtestSimpleQuery -Dtests.seed=3DDB6C43B805DBF997 -Dte= sts.multiplier=3D3 -Dtests.slow=3Dtrue -Dtests.locale=3Dnb-SJ -Dtests.timez= one=3DAntarctica/South_Pole -Dtests.asserts=3Dtrue -Dtests.file.encoding=3D= ISO-8859-1 [junit4] ERROR 11.2s J0 | TestLTROnSolrCloud.testSimpleQuery <<< [junit4] > Throwable #1: java.lang.RuntimeException: Path not found: = /responseHeader/status [junit4] > =09at __randomizedtesting.SeedInfo.seed([DB6C43B805DBF997:= AE6183A415C13F42]:0) [junit4] > =09at org.apache.solr.util.RestTestBase.assertJPut(RestTes= tBase.java:329) [junit4] > =09at org.apache.solr.util.RestTestBase.assertJPut(RestTes= tBase.java:271) [junit4] > =09at org.apache.solr.ltr.TestRerankBase.loadFeature(TestR= erankBase.java:286) [junit4] > =09at org.apache.solr.ltr.TestLTROnSolrCloud.loadModelsAnd= Features(TestLTROnSolrCloud.java:184) [junit4] > =09at org.apache.solr.ltr.TestLTROnSolrCloud.setupSolrClus= ter(TestLTROnSolrCloud.java:138) [junit4] > =09at org.apache.solr.ltr.TestLTROnSolrCloud.setUp(TestLTR= OnSolrCloud.java:58) [junit4] > =09at java.base/jdk.internal.reflect.NativeMethodAccessorI= mpl.invoke0(Native Method) [junit4] > =09at java.base/jdk.internal.reflect.NativeMethodAccessorI= mpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] > =09at java.base/jdk.internal.reflect.DelegatingMethodAcces= sorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] > =09at java.base/java.lang.reflect.Method.invoke(Method.jav= a:564) [junit4] > =09at java.base/java.lang.Thread.run(Thread.java:844) [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/wo= rkspace/Lucene-Solr-master-Linux/solr/build/contrib/solr-ltr/test/J0/temp/s= olr.ltr.TestLTROnSolrCloud_DB6C43B805DBF997-001 [junit4] 2> Jun 21, 2017 6:22:27 PM com.carrotsearch.randomizedtesting= .ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thre= ad(s). [junit4] 2> NOTE: test params are: codec=3DAsserting(Lucene70): {_vers= ion_=3DFST50, popularity=3DPostingsFormat(name=3DMemory), description=3DBlo= ckTreeOrds(blocksize=3D128), id=3DPostingsFormat(name=3DMemory), text=3DPos= tingsFormat(name=3DLuceneFixedGap), title=3DBlockTreeOrds(blocksize=3D128)}= , docValues:{}, maxPointsInLeafNode=3D468, maxMBSortInHeap=3D6.262882225670= 827, sim=3DRandomSimilarity(queryNorm=3Dtrue): {}, locale=3Dnb-SJ, timezone= =3DAntarctica/South_Pole [junit4] 2> NOTE: Linux 4.10.0-21-generic i386/Oracle Corporation 9-ea= (32-bit)/cpus=3D8,threads=3D1,free=3D35463816,total=3D75497472 [junit4] 2> NOTE: All tests run in this JVM: [TestLTROnSolrCloud] [junit4] Completed [16/33 (1!)] on J0 in 13.19s, 1 test, 1 error <<< FAI= LURES! [...truncated 29945 lines...] ------=_Part_112_931183440.1498069541044 Content-Type: text/plain; charset=us-ascii --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org For additional commands, e-mail: dev-help@lucene.apache.org ------=_Part_112_931183440.1498069541044--