From dev-return-354567-archive-asf-public=cust-asf.ponee.io@lucene.apache.org Wed May 1 11:55:44 2019 Return-Path: X-Original-To: archive-asf-public@cust-asf.ponee.io Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [207.244.88.153]) by mx-eu-01.ponee.io (Postfix) with SMTP id 3CB6F180629 for ; Wed, 1 May 2019 13:55:43 +0200 (CEST) Received: (qmail 64827 invoked by uid 500); 1 May 2019 11:55:41 -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 64817 invoked by uid 99); 1 May 2019 11:55:40 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd3-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 01 May 2019 11:55:40 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd3-us-west.apache.org (ASF Mail Server at spamd3-us-west.apache.org) with ESMTP id C1CD6180C96 for ; Wed, 1 May 2019 11:55:39 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd3-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -0.299 X-Spam-Level: X-Spam-Status: No, score=-0.299 tagged_above=-999 required=6.31 tests=[KAM_BADIPHTTP=2, RCVD_IN_DNSWL_MED=-2.3, SPF_PASS=-0.001, URIBL_BLOCKED=0.001, WEIRD_PORT=0.001] autolearn=disabled Received: from mx1-lw-eu.apache.org ([10.40.0.8]) by localhost (spamd3-us-west.apache.org [10.40.0.10]) (amavisd-new, port 10024) with ESMTP id TJOUA81D8-Ym for ; Wed, 1 May 2019 11:55:32 +0000 (UTC) Received: from serv1.sd-datasolutions.de (serv1.sd-datasolutions.de [88.99.242.108]) by mx1-lw-eu.apache.org (ASF Mail Server at mx1-lw-eu.apache.org) with ESMTP id 882875F3AF for ; Wed, 1 May 2019 11:55:32 +0000 (UTC) Received: from serv1 (ip6-localhost [IPv6:::1]) by serv1.sd-datasolutions.de (Postfix) with ESMTP id 564A810800DF for ; Wed, 1 May 2019 11:55:32 +0000 (UTC) Date: Wed, 1 May 2019 11:53:07 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org Message-ID: <314482860.39.1556711732354.JavaMail.jenkins@serv1.sd-datasolutions.de> In-Reply-To: <29041610.31.1556697678336.JavaMail.jenkins@serv1.sd-datasolutions.de> References: <29041610.31.1556697678336.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS] Lucene-Solr-master-Linux (64bit/jdk-11.0.2) - Build # 24015 - Still Failing! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_38_1623113885.1556711732287" X-Jenkins-Job: Lucene-Solr-master-Linux X-Jenkins-Result: FAILURE ------=_Part_38_1623113885.1556711732287 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Linux/24015/ Java: 64bit/jdk-11.0.2 -XX:+UseCompressedOops -XX:+UseParallelGC 4 tests failed. FAILED: org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat Error Message: re-indexing warning not found Stack Trace: java.lang.AssertionError: re-indexing warning not found =09at __randomizedtesting.SeedInfo.seed([DA3D7AEE4E77C8B8:AAC8D9472EBF61CE]= :0) =09at org.junit.Assert.fail(Assert.java:88) =09at org.junit.Assert.assertTrue(Assert.java:41) =09at org.apache.solr.cloud.SystemCollectionCompatTest.testBackCompat(Syste= mCollectionCompatTest.java:203) =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:566) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1750) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:938) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:974) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:988) =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:947) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:832) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:883) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:894) =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:834) FAILED: org.apache.solr.update.TestInPlaceUpdatesDistrib.test Error Message: Thread pool didn't terminate within 15 secs Stack Trace: java.lang.AssertionError: Thread pool didn't terminate within 15 secs =09at __randomizedtesting.SeedInfo.seed([DA3D7AEE4E77C8B8:52694534E08BA540]= :0) =09at org.junit.Assert.fail(Assert.java:88) =09at org.junit.Assert.assertTrue(Assert.java:41) =09at org.apache.solr.update.TestInPlaceUpdatesDistrib.reorderedDeletesTest= (TestInPlaceUpdatesDistrib.java:776) =09at org.apache.solr.update.TestInPlaceUpdatesDistrib.test(TestInPlaceUpda= tesDistrib.java:175) =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:566) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1750) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:938) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:974) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:988) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= FixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= Statement.evaluate(BaseDistributedSearchTestCase.java:1054) =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:947) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:832) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:883) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:894) =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:834) FAILED: org.apache.solr.update.PeerSyncTest.test Error Message: Unexpected exception type, expected SolrException but got org.apache.solr.c= lient.solrj.SolrServerException: Timeout occurred while waiting response fr= om server at: http://127.0.0.1:42005/w_p/co/collection1 Stack Trace: junit.framework.AssertionFailedError: Unexpected exception type, expected S= olrException but got org.apache.solr.client.solrj.SolrServerException: Time= out occurred while waiting response from server at: http://127.0.0.1:42005/= w_p/co/collection1 =09at __randomizedtesting.SeedInfo.seed([DA3D7AEE4E77C8B8:52694534E08BA540]= :0) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2699) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2688) =09at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279) =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:566) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1750) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:938) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:974) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:988) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= FixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= Statement.evaluate(BaseDistributedSearchTestCase.java:1054) =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:947) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:832) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:883) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:894) =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:834) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurr= ed while waiting response from server at: http://127.0.0.1:42005/w_p/co/col= lection1 =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:660) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:255) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:244) =09at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207= ) =09at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224= ) =09at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSear= chTestCase.java:576) =09at org.apache.solr.update.PeerSyncTest.lambda$test$0(PeerSyncTest.java:2= 81) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2694) =09... 42 more Caused by: java.net.SocketTimeoutException: Read timed out =09at java.base/java.net.SocketInputStream.socketRead0(Native Method) =09at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.jav= a:115) =09at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168) =09at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140) =09at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInpu= tBufferImpl.java:137) =09at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInpu= tBufferImpl.java:153) =09at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputB= ufferImpl.java:282) =09at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(Default= HttpResponseParser.java:138) =09at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(Default= HttpResponseParser.java:56) =09at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessagePa= rser.java:259) =09at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHead= er(DefaultBHttpClientConnection.java:163) =09at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy= .java:165) =09at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRe= questExecutor.java:273) =09at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecu= tor.java:125) =09at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.= java:272) =09at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java= :185) =09at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) =09at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java= :110) =09at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttp= Client.java:185) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:83) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:56) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:548) =09... 49 more FAILED: org.apache.solr.update.PeerSyncWithLeaderTest.test Error Message: Unexpected exception type, expected SolrException but got org.apache.solr.c= lient.solrj.SolrServerException: Timeout occurred while waiting response fr= om server at: http://127.0.0.1:42405/collection1 Stack Trace: junit.framework.AssertionFailedError: Unexpected exception type, expected S= olrException but got org.apache.solr.client.solrj.SolrServerException: Time= out occurred while waiting response from server at: http://127.0.0.1:42405/= collection1 =09at __randomizedtesting.SeedInfo.seed([DA3D7AEE4E77C8B8:52694534E08BA540]= :0) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2699) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2688) =09at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279) =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:566) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1750) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:938) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:974) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:988) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= FixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082) =09at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$Shards= Statement.evaluate(BaseDistributedSearchTestCase.java:1054) =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:947) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:832) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:883) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:894) =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:834) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurr= ed while waiting response from server at: http://127.0.0.1:42405/collection= 1 =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:660) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:255) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:244) =09at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:207= ) =09at org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:224= ) =09at org.apache.solr.BaseDistributedSearchTestCase.add(BaseDistributedSear= chTestCase.java:576) =09at org.apache.solr.update.PeerSyncTest.lambda$test$0(PeerSyncTest.java:2= 81) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2694) =09... 42 more Caused by: java.net.SocketTimeoutException: Read timed out =09at java.base/java.net.SocketInputStream.socketRead0(Native Method) =09at java.base/java.net.SocketInputStream.socketRead(SocketInputStream.jav= a:115) =09at java.base/java.net.SocketInputStream.read(SocketInputStream.java:168) =09at java.base/java.net.SocketInputStream.read(SocketInputStream.java:140) =09at org.apache.http.impl.io.SessionInputBufferImpl.streamRead(SessionInpu= tBufferImpl.java:137) =09at org.apache.http.impl.io.SessionInputBufferImpl.fillBuffer(SessionInpu= tBufferImpl.java:153) =09at org.apache.http.impl.io.SessionInputBufferImpl.readLine(SessionInputB= ufferImpl.java:282) =09at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(Default= HttpResponseParser.java:138) =09at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(Default= HttpResponseParser.java:56) =09at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessagePa= rser.java:259) =09at org.apache.http.impl.DefaultBHttpClientConnection.receiveResponseHead= er(DefaultBHttpClientConnection.java:163) =09at org.apache.http.impl.conn.CPoolProxy.receiveResponseHeader(CPoolProxy= .java:165) =09at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRe= questExecutor.java:273) =09at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecu= tor.java:125) =09at org.apache.http.impl.execchain.MainClientExec.execute(MainClientExec.= java:272) =09at org.apache.http.impl.execchain.ProtocolExec.execute(ProtocolExec.java= :185) =09at org.apache.http.impl.execchain.RetryExec.execute(RetryExec.java:89) =09at org.apache.http.impl.execchain.RedirectExec.execute(RedirectExec.java= :110) =09at org.apache.http.impl.client.InternalHttpClient.doExecute(InternalHttp= Client.java:185) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:83) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:56) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:548) =09... 49 more Build Log: [...truncated 13520 lines...] [junit4] Suite: org.apache.solr.update.PeerSyncWithLeaderTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-mast= er-Linux/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTe= st_DA3D7AEE4E77C8B8-001/init-core-data-001 [junit4] 2> 703555 INFO (SUITE-PeerSyncWithLeaderTest-seed#[DA3D7AEE4= E77C8B8]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POI= NTS_SYSPROP=3Dtrue) w/NUMERIC_DOCVALUES_SYSPROP=3Dfalse [junit4] 2> 703556 INFO (SUITE-PeerSyncWithLeaderTest-seed#[DA3D7AEE4= E77C8B8]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and cli= entAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=3D"= https://issues.apache.org/jira/browse/SOLR-5776") [junit4] 2> 703556 INFO (SUITE-PeerSyncWithLeaderTest-seed#[DA3D7AEE4= E77C8B8]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: te= st.solr.allowed.securerandom=3Dnull & java.security.egd=3Dfile:/dev/./urand= om [junit4] 2> 703556 INFO (SUITE-PeerSyncWithLeaderTest-seed#[DA3D7AEE4= E77C8B8]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostCon= text system property: / [junit4] 2> 703556 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 703557 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to clas= sloader, from paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr= /core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-S= olr-master-Linux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 703569 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 703579 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.IndexSchema [null] Schema name=3Dtest [junit4] 2> 703637 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with unique= id field id [junit4] 2> 703694 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initi= alized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingE= nabled=3Dfalse] [junit4] 2> 703696 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@5d7ac5fc[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 703698 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@b02534b[provider=3Dnull,keyStore=3D= null,trustStore=3Dnull] [junit4] 2> 703709 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating trans= ient cache for 2147483647 transient cores [junit4] 2> 703709 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection,= keeping metrics history in memory. [junit4] 2> 703722 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.nod= e' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBe= anServer@74cbbbb9 [junit4] 2> 703727 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm= ' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean= Server@74cbbbb9 [junit4] 2> 703727 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jet= ty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxM= BeanServer@74cbbbb9 [junit4] 2> 703728 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from= paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/tes= t-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 703742 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 703756 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 703816 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 703821 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configu= ration from instancedir /home/jenkins/workspace/Lucene-Solr-master-Linux/so= lr/core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 703821 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1= ' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanse= rver.JmxMBeanServer@74cbbbb9 [junit4] 2> 703821 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/je= nkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/coll= ection1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/= build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E7= 7C8B8-001/init-core-data-001/] [junit4] 2> 703822 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D1660861281, maxMergeSizeForForcedMer= ge=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D214= 7483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 703823 WARN (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = =3D requestHandler,name =3D /dump,class =3D DumpRequestHandler,attributes = =3D {initParams=3Da, name=3D/dump, class=3DDumpRequestHandler},args =3D {de= faults=3D{a=3DA,b=3DB}}} [junit4] 2> 703847 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.so= lr.update.UpdateLog [junit4] 2> 703847 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLev= el=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 703847 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 703847 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 703847 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D33,= maxMergeAtOnceExplicit=3D27, maxMergedSegmentMB=3D44.005859375, floorSegme= ntMB=3D1.60546875, forceMergeDeletesPctAllowed=3D25.042060324979566, segmen= tsPerTier=3D43.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.22701079686478318, deletesPctAllowed=3D35.60037165876453 [junit4] 2> 703848 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.s.SolrIndexSearcher Opening [Searcher@4ac771ad[collection1] m= ain] [junit4] 2> 703848 WARN (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /ho= me/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr= /collection1/conf; switching to use InMemory storage instead. [junit4] 2> 703848 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 703848 INFO (coreLoadExecutor-6089-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Could not find max version in index or recent upd= ates, using new clock 1632328245040906240 [junit4] 2> 703850 INFO (searcherExecutor-6090-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@4ac771ad[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 703850 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 703939 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /= home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J= 2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDir-001/= control/cores/collection1 [junit4] 2> 703939 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket c= lose linger time [junit4] 2> 703939 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original conf= igured port=3D0) [junit4] 2> 703939 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on p= ort 0 try number 1 ... [junit4] 2> 703939 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-= 14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2= +9 [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dn= ode0 [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session No SessionScavenger set, using default= s [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContex= tHandler@30e741f1{/,null,AVAILABLE} [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@54e8= 09b7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43017} [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server Started @703965ms [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema= =3Dschema.xml, hostContext=3D/, solrconfig=3Dsolrconfig-tlog.xml, hostPort= =3D43017, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA= 3D7AEE4E77C8B8-001/tempDir-001/control/cores} [junit4] 2> 703941 ERROR (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.l= og.dir. Logging may be missing or incomplete. [junit4] 2> 703941 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.ap= ache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 703942 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome t= o Apache Solr=E2=84=A2 version 9.0.0 [junit4] 2> 703942 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting = in standalone mode on port null [junit4] 2> 703942 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install d= ir: null [junit4] 2> 703942 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start tim= e: 2019-05-01T11:18:43.334063Z [junit4] 2> 703942 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration = from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/= test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDi= r-001/control/solr.xml [junit4] 2> 703944 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverWorkLoopDelay is ignored [junit4] 2> 703944 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverBadNodeExpiration is ignored [junit4] 2> 703944 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.= mbeanserver.JmxMBeanServer@74cbbbb9, but no JMX reporters were configured -= adding default JMX reporter. [junit4] 2> 704102 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initi= alized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingE= nabled=3Dfalse] [junit4] 2> 704102 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@3c36ee12[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704104 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@188fe94d[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704112 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating trans= ient cache for 4 transient cores [junit4] 2> 704112 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection,= keeping metrics history in memory. [junit4] 2> 704122 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.nod= e' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBe= anServer@74cbbbb9 [junit4] 2> 704129 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm= ' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean= Server@74cbbbb9 [junit4] 2> 704129 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jet= ty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxM= BeanServer@74cbbbb9 [junit4] 2> 704130 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions= underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/sol= r-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001= /tempDir-001/control/cores [junit4] 2> 704130 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 704131 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from= paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/tes= t-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 704145 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 704162 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 704230 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 704237 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configu= ration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr= /core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 704238 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1= ' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanse= rver.JmxMBeanServer@74cbbbb9 [junit4] 2> 704238 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/je= nkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/coll= ection1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/= build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E7= 7C8B8-001/tempDir-001/control/cores/collection1/data/] [junit4] 2> 704239 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D1660861281, maxMergeSizeForForcedMer= ge=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D214= 7483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 704241 WARN (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = =3D requestHandler,name =3D /dump,class =3D DumpRequestHandler,attributes = =3D {initParams=3Da, name=3D/dump, class=3DDumpRequestHandler},args =3D {de= faults=3D{a=3DA,b=3DB}}} [junit4] 2> 704276 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.so= lr.update.UpdateLog [junit4] 2> 704276 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLev= el=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 704278 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 704278 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 704278 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D33,= maxMergeAtOnceExplicit=3D27, maxMergedSegmentMB=3D44.005859375, floorSegme= ntMB=3D1.60546875, forceMergeDeletesPctAllowed=3D25.042060324979566, segmen= tsPerTier=3D43.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.22701079686478318, deletesPctAllowed=3D35.60037165876453 [junit4] 2> 704279 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.s.SolrIndexSearcher Opening [Searcher@651be9f1[collection1] m= ain] [junit4] 2> 704279 WARN (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /ho= me/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr= /collection1/conf; switching to use InMemory storage instead. [junit4] 2> 704279 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 704279 INFO (coreLoadExecutor-6103-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Could not find max version in index or recent upd= ates, using new clock 1632328245492842496 [junit4] 2> 704288 INFO (searcherExecutor-6104-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@651be9f1[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 704343 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /= home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J= 2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDir-001/= shard0/cores/collection1 [junit4] 2> 704344 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket c= lose linger time [junit4] 2> 704344 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original conf= igured port=3D0) [junit4] 2> 704344 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on p= ort 0 try number 1 ... [junit4] 2> 704344 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-= 14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2= +9 [junit4] 2> 704345 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dn= ode0 [junit4] 2> 704345 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session No SessionScavenger set, using default= s [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContex= tHandler@328791d6{/,null,AVAILABLE} [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@6d92= 3256{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42405} [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server Started @704370ms [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema= =3Dschema.xml, hostContext=3D/, solrconfig=3Dsolrconfig-tlog.xml, hostPort= =3D42405, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA= 3D7AEE4E77C8B8-001/tempDir-001/shard0/cores} [junit4] 2> 704346 ERROR (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.l= og.dir. Logging may be missing or incomplete. [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.ap= ache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome t= o Apache Solr=E2=84=A2 version 9.0.0 [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting = in standalone mode on port null [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install d= ir: null [junit4] 2> 704346 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start tim= e: 2019-05-01T11:18:43.738824Z [junit4] 2> 704347 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration = from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/= test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDi= r-001/shard0/solr.xml [junit4] 2> 704349 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverWorkLoopDelay is ignored [junit4] 2> 704349 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverBadNodeExpiration is ignored [junit4] 2> 704349 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.= mbeanserver.JmxMBeanServer@74cbbbb9, but no JMX reporters were configured -= adding default JMX reporter. [junit4] 2> 704418 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initi= alized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingE= nabled=3Dfalse] [junit4] 2> 704418 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@189fbfba[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704421 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@2864b3b4[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704434 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating trans= ient cache for 4 transient cores [junit4] 2> 704434 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection,= keeping metrics history in memory. [junit4] 2> 704451 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.nod= e' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBe= anServer@74cbbbb9 [junit4] 2> 704464 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm= ' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean= Server@74cbbbb9 [junit4] 2> 704464 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jet= ty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxM= BeanServer@74cbbbb9 [junit4] 2> 704465 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions= underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/sol= r-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001= /tempDir-001/shard0/cores [junit4] 2> 704465 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 704466 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from= paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/tes= t-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 704485 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 704498 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 704591 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 704599 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configu= ration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr= /core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 704599 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1= ' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanse= rver.JmxMBeanServer@74cbbbb9 [junit4] 2> 704599 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/je= nkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/coll= ection1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/= build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E7= 7C8B8-001/tempDir-001/shard0/cores/collection1/data/] [junit4] 2> 704600 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D1660861281, maxMergeSizeForForcedMer= ge=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D214= 7483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 704601 WARN (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = =3D requestHandler,name =3D /dump,class =3D DumpRequestHandler,attributes = =3D {initParams=3Da, name=3D/dump, class=3DDumpRequestHandler},args =3D {de= faults=3D{a=3DA,b=3DB}}} [junit4] 2> 704634 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.so= lr.update.UpdateLog [junit4] 2> 704634 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLev= el=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 704635 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 704635 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 704636 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D33,= maxMergeAtOnceExplicit=3D27, maxMergedSegmentMB=3D44.005859375, floorSegme= ntMB=3D1.60546875, forceMergeDeletesPctAllowed=3D25.042060324979566, segmen= tsPerTier=3D43.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.22701079686478318, deletesPctAllowed=3D35.60037165876453 [junit4] 2> 704636 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.s.SolrIndexSearcher Opening [Searcher@6029cf3d[collection1] m= ain] [junit4] 2> 704636 WARN (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /ho= me/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr= /collection1/conf; switching to use InMemory storage instead. [junit4] 2> 704637 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 704637 INFO (coreLoadExecutor-6117-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Could not find max version in index or recent upd= ates, using new clock 1632328245868232704 [junit4] 2> 704639 INFO (searcherExecutor-6118-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@6029cf3d[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 704735 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /= home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J= 2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDir-001/= shard1/cores/collection1 [junit4] 2> 704736 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket c= lose linger time [junit4] 2> 704736 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original conf= igured port=3D0) [junit4] 2> 704736 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on p= ort 0 try number 1 ... [junit4] 2> 704736 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-= 14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2= +9 [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dn= ode0 [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session No SessionScavenger set, using default= s [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContex= tHandler@1fc5fdbd{/,null,AVAILABLE} [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@57ad= 1a60{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:40079} [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server Started @704761ms [junit4] 2> 704737 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema= =3Dschema.xml, hostContext=3D/, solrconfig=3Dsolrconfig-tlog.xml, hostPort= =3D40079, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA= 3D7AEE4E77C8B8-001/tempDir-001/shard1/cores} [junit4] 2> 704738 ERROR (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.l= og.dir. Logging may be missing or incomplete. [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.ap= ache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome t= o Apache Solr=E2=84=A2 version 9.0.0 [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting = in standalone mode on port null [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install d= ir: null [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start tim= e: 2019-05-01T11:18:44.130325Z [junit4] 2> 704738 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration = from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/= test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDi= r-001/shard1/solr.xml [junit4] 2> 704740 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverWorkLoopDelay is ignored [junit4] 2> 704740 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverBadNodeExpiration is ignored [junit4] 2> 704741 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.= mbeanserver.JmxMBeanServer@74cbbbb9, but no JMX reporters were configured -= adding default JMX reporter. [junit4] 2> 704785 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initi= alized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingE= nabled=3Dfalse] [junit4] 2> 704786 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@731c07d1[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704788 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@6466974b[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 704800 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating trans= ient cache for 4 transient cores [junit4] 2> 704800 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection,= keeping metrics history in memory. [junit4] 2> 704826 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.nod= e' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBe= anServer@74cbbbb9 [junit4] 2> 704837 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm= ' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean= Server@74cbbbb9 [junit4] 2> 704837 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jet= ty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxM= BeanServer@74cbbbb9 [junit4] 2> 704838 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions= underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/sol= r-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001= /tempDir-001/shard1/cores [junit4] 2> 704838 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 704839 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from= paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/tes= t-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 704853 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 704865 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 704948 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 704955 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configu= ration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr= /core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 704955 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1= ' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanse= rver.JmxMBeanServer@74cbbbb9 [junit4] 2> 704955 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/je= nkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/coll= ection1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/= build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E7= 7C8B8-001/tempDir-001/shard1/cores/collection1/data/] [junit4] 2> 704957 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D1660861281, maxMergeSizeForForcedMer= ge=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D214= 7483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 704958 WARN (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = =3D requestHandler,name =3D /dump,class =3D DumpRequestHandler,attributes = =3D {initParams=3Da, name=3D/dump, class=3DDumpRequestHandler},args =3D {de= faults=3D{a=3DA,b=3DB}}} [junit4] 2> 704991 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.so= lr.update.UpdateLog [junit4] 2> 704991 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLev= el=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 704992 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 704992 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 704993 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D33,= maxMergeAtOnceExplicit=3D27, maxMergedSegmentMB=3D44.005859375, floorSegme= ntMB=3D1.60546875, forceMergeDeletesPctAllowed=3D25.042060324979566, segmen= tsPerTier=3D43.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.22701079686478318, deletesPctAllowed=3D35.60037165876453 [junit4] 2> 704993 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.s.SolrIndexSearcher Opening [Searcher@2e0686a3[collection1] m= ain] [junit4] 2> 704993 WARN (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /ho= me/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr= /collection1/conf; switching to use InMemory storage instead. [junit4] 2> 704994 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 704994 INFO (coreLoadExecutor-6131-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Could not find max version in index or recent upd= ates, using new clock 1632328246242574336 [junit4] 2> 704995 INFO (searcherExecutor-6132-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@2e0686a3[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 705098 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /= home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/test/J= 2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDir-001/= shard2/cores/collection1 [junit4] 2> 705099 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket c= lose linger time [junit4] 2> 705099 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original conf= igured port=3D0) [junit4] 2> 705099 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on p= ort 0 try number 1 ... [junit4] 2> 705099 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-= 14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 11.0.2= +9 [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dn= ode0 [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session No SessionScavenger set, using default= s [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContex= tHandler@3ac49d97{/,null,AVAILABLE} [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@8f29= 01c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:42707} [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.s.Server Started @705124ms [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema= =3Dschema.xml, hostContext=3D/, solrconfig=3Dsolrconfig-tlog.xml, hostPort= =3D42707, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA= 3D7AEE4E77C8B8-001/tempDir-001/shard2/cores} [junit4] 2> 705100 ERROR (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.l= og.dir. Logging may be missing or incomplete. [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.ap= ache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome t= o Apache Solr=E2=84=A2 version 9.0.0 [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting = in standalone mode on port null [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install d= ir: null [junit4] 2> 705100 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start tim= e: 2019-05-01T11:18:44.492926Z [junit4] 2> 705101 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration = from /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/solr-core/= test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001/tempDi= r-001/shard2/solr.xml [junit4] 2> 705102 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverWorkLoopDelay is ignored [junit4] 2> 705102 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoRepl= icaFailoverBadNodeExpiration is ignored [junit4] 2> 705103 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.= mbeanserver.JmxMBeanServer@74cbbbb9, but no JMX reporters were configured -= adding default JMX reporter. [junit4] 2> 705231 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initi= alized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingE= nabled=3Dfalse] [junit4] 2> 705232 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@192db1e[provider=3Dnull,keyStore=3D= null,trustStore=3Dnull] [junit4] 2> 705234 WARN (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlg= orithm configured for SslContextFactory@75adba31[provider=3Dnull,keyStore= =3Dnull,trustStore=3Dnull] [junit4] 2> 705242 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating trans= ient cache for 4 transient cores [junit4] 2> 705242 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection,= keeping metrics history in memory. [junit4] 2> 705252 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.nod= e' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBe= anServer@74cbbbb9 [junit4] 2> 705260 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm= ' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBean= Server@74cbbbb9 [junit4] 2> 705260 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jet= ty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxM= BeanServer@74cbbbb9 [junit4] 2> 705261 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions= underneath /home/jenkins/workspace/Lucene-Solr-master-Linux/solr/build/sol= r-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E77C8B8-001= /tempDir-001/shard2/cores [junit4] 2> 705261 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 705261 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from= paths: [/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/tes= t-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-master-Li= nux/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 705275 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0 [junit4] 2> 705288 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 705360 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 705365 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configu= ration from configset /home/jenkins/workspace/Lucene-Solr-master-Linux/solr= /core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 705365 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1= ' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanse= rver.JmxMBeanServer@74cbbbb9 [junit4] 2> 705365 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/je= nkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr/coll= ection1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-master-Linux/solr/= build/solr-core/test/J2/temp/solr.update.PeerSyncWithLeaderTest_DA3D7AEE4E7= 7C8B8-001/tempDir-001/shard2/cores/collection1/data/] [junit4] 2> 705366 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D1660861281, maxMergeSizeForForcedMer= ge=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D214= 7483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 705367 WARN (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type = =3D requestHandler,name =3D /dump,class =3D DumpRequestHandler,attributes = =3D {initParams=3Da, name=3D/dump, class=3DDumpRequestHandler},args =3D {de= faults=3D{a=3DA,b=3DB}}} [junit4] 2> 705387 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.so= lr.update.UpdateLog [junit4] 2> 705387 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLev= el=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 705388 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 705388 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 705389 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apac= he.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D33,= maxMergeAtOnceExplicit=3D27, maxMergedSegmentMB=3D44.005859375, floorSegme= ntMB=3D1.60546875, forceMergeDeletesPctAllowed=3D25.042060324979566, segmen= tsPerTier=3D43.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.22701079686478318, deletesPctAllowed=3D35.60037165876453 [junit4] 2> 705389 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.s.SolrIndexSearcher Opening [Searcher@7a4f7a11[collection1] m= ain] [junit4] 2> 705389 WARN (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /ho= me/jenkins/workspace/Lucene-Solr-master-Linux/solr/core/src/test-files/solr= /collection1/conf; switching to use InMemory storage instead. [junit4] 2> 705389 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 705389 INFO (coreLoadExecutor-6145-thread-1) [ x:colle= ction1] o.a.s.u.UpdateLog Could not find max version in index or recent upd= ates, using new clock 1632328246656761856 [junit4] 2> 705391 INFO (TEST-PeerSyncWithLeaderTest.test-seed#[DA3D7= AEE4E77C8B8]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 705391 INFO (searcherExecutor-6146-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@7a4f7a11[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 705394 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D path=3D/update pa= rams=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[1 (1)]= } 0 1 [junit4] 2> 705395 WARN (qtp1859345790-18306) [ x:collection1] o.a= .s.u.PeerSyncWithLeader no frame of reference to tell if we've missed updat= es [junit4] 2> 705395 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{syncWithLeade= r=3Dhttp://127.0.0.1:42405/collection1&qt=3D/get&getVersions=3D100&wt=3Djav= abin&version=3D2} status=3D0 QTime=3D0 [junit4] 2> 705396 INFO (qtp1859345790-18307) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D path=3D/update pa= rams=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[1 (1)]= } 0 0 [junit4] 2> 705397 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader PeerSync: core=3Dcollection1 url=3D START leader=3D= http://127.0.0.1:42405/collection1 nUpdates=3D100 [junit4] 2> 705400 INFO (qtp1119136879-18284) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@32e59866[collection1] realtime] [junit4] 2> 705400 INFO (qtp1119136879-18284) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:2.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, version= sHash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 705400 INFO (qtp1119136879-18284) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{distrib=3Dfal= se&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&version=3D2}= status=3D0 QTime=3D2 [junit4] 2> 705402 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@2149397d[collection1] realtime] [junit4] 2> 705402 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:2.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, version= sHash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 705403 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader Fingerprint comparison result: 0 [junit4] 2> 705403 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{syncWithLeade= r=3Dhttp://127.0.0.1:42405/collection1&qt=3D/get&getVersions=3D100&wt=3Djav= abin&version=3D2} status=3D0 QTime=3D5 [junit4] 2> 705403 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 start commit{_version_=3D1632328246671441920,opti= mize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse= ,softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 705403 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.S= olrIndexWriter@1a5b1409 commitCommandVersion:1632328246671441920 [junit4] 2> 705404 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@37a5ce01[collection1] main] [junit4] 2> 705404 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 705406 INFO (searcherExecutor-6118-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@37a5ce01[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics=3D{java.runt= ime.version=3D11.0.2+9, os.version=3D4.18.0-17-generic, os=3DLinux, java.ve= ndor=3DOracle Corporation, timestamp=3D1556709524791, java.version=3D11.0.2= , java.vm.version=3D11.0.2+9, lucene.version=3D9.0.0, source=3Dflush, os.ar= ch=3Damd64}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST_SPEED}])= ))} [junit4] 2> 705406 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D path=3D/update pa= rams=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djavabin&v= ersion=3D2}{commit=3D} 0 3 [junit4] 2> 705406 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 start commit{_version_=3D1632328246674587648,opti= mize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse= ,softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 705406 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.S= olrIndexWriter@484d0e2 commitCommandVersion:1632328246674587648 [junit4] 2> 705407 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@3ce6519e[collection1] main] [junit4] 2> 705408 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 705409 INFO (searcherExecutor-6132-thread-1-processing-x:= collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered = new searcher Searcher@3ce6519e[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader(Uninverting(_0(9.0.0):C1:[diagnostics=3D{java.runt= ime.version=3D11.0.2+9, os.version=3D4.18.0-17-generic, os=3DLinux, java.ve= ndor=3DOracle Corporation, timestamp=3D1556709524793, java.version=3D11.0.2= , java.vm.version=3D11.0.2+9, lucene.version=3D9.0.0, source=3Dflush, os.ar= ch=3Damd64}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST_SPEED}])= ))} [junit4] 2> 705409 INFO (qtp1859345790-18306) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D path=3D/update pa= rams=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djavabin&v= ersion=3D2}{commit=3D} 0 2 [junit4] 2> 705409 INFO (qtp1119136879-18286) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/select params=3D{q=3D*:*&wt= =3Djavabin&version=3D2} hits=3D1 status=3D0 QTime=3D0 [junit4] 2> 705410 INFO (qtp1859345790-18307) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/select params=3D{q=3D*:*&wt= =3Djavabin&version=3D2} hits=3D1 status=3D0 QTime=3D0 [junit4] 2> 705412 INFO (qtp1119136879-18284) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D path=3D/update pa= rams=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[2 (2)]= } 0 1 [junit4] 2> 705412 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader PeerSync: core=3Dcollection1 url=3D START leader=3D= http://127.0.0.1:42405/collection1 nUpdates=3D100 [junit4] 2> 705416 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@2253ec2f[collection1] realtime] [junit4] 2> 705416 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:3.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, version= sHash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 705416 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{distrib=3Dfal= se&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&version=3D2}= status=3D0 QTime=3D3 [junit4] 2> 705417 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, version= sHash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 705417 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader Fingerprint comparison result: 1 [junit4] 2> 705417 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader Leader fingerprint: {maxVersionSpecified=3D92233720= 36854775807, maxVersionEncountered=3D2, maxInHash=3D2, versionsHash=3D-1218= 814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1}, Our fingerprint= : {maxVersionSpecified=3D9223372036854775807, maxVersionEncountered=3D1, ma= xInHash=3D1, versionsHash=3D-5451962507482445012, numVersions=3D1, numDocs= =3D1, maxDoc=3D1} [junit4] 2> 705417 INFO (qtp1119136879-18286) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, version= sHash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 705417 INFO (qtp1119136879-18286) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{distrib=3Dfal= se&qt=3D/get&fingerprint=3Dtrue&getVersions=3D100&wt=3Djavabin&version=3D2}= status=3D0 QTime=3D0 [junit4] 2> 705417 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader Leader fingerprint {maxVersionSpecified=3D922337203= 6854775807, maxVersionEncountered=3D2, maxInHash=3D2, versionsHash=3D-12188= 14014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 705420 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader PeerSync: core=3Dcollection1 url=3D Received 2 ver= sions from http://127.0.0.1:42405/collection1 [junit4] 2> 705425 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader PeerSync: core=3Dcollection1 url=3D Requesting upda= tes from http://127.0.0.1:42405/collection1 n=3D1 versions=3D2 [junit4] 2> 705426 INFO (qtp1119136879-18284) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{getUpdates=3D= 2&distrib=3Dfalse&qt=3D/get&onlyIfActive=3Dfalse&skipDbq=3Dtrue&wt=3Djavabi= n&version=3D2} status=3D0 QTime=3D0 [junit4] 2> 705428 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.p.LogUpdateProcessorFactory [collection1] {add=3D[2 (2)]} 0 1 [junit4] 2> 705431 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@1fe9fbc0[collection1] realtime] [junit4] 2> 705431 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.IndexFingerprint IndexFingerprint millis:3.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, version= sHash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 705431 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader Fingerprint comparison result: 0 [junit4] 2> 705431 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.u.PeerSyncWithLeader PeerSync: core=3Dcollection1 url=3D DONE. sync succ= eeded [junit4] 2> 705431 INFO (qtp1859345790-18305) [ x:collection1] o.a= .s.c.S.Request [collection1] webapp=3D path=3D/get params=3D{syncWithLeade= r=3Dhttp://127.0.0.1:42405/collection1&qt=3D/get&getVersions=3D100&wt=3Djav= abin&version=3D2} status=3D0 QTime=3D19 [junit4] 2> 705432 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 start commit{_version_=3D1632328246701850624,opti= mize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse= ,softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 705432 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.S= olrIndexWriter@1a5b1409 commitCommandVersion:1632328246701850624 [junit4] 2> 705432 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.s.SolrIndexSearcher Opening [Searcher@5c7ccecb[collection1] main] [junit4] 2> 705433 INFO (qtp1119136879-18285) [ x:collection1] o.a= .s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 705434 INFO (searche [...truncated too long message...] uesFormat(name=3DDirect), range_facet_l=3DDocValuesFormat(name=3DDirect), n= _f1=3DDocValuesFormat(name=3DLucene80), n_ti1=3DDocValuesFormat(name=3DLuce= ne80), n_tl1=3DDocValuesFormat(name=3DLucene80), _version_=3DDocValuesForma= t(name=3DDirect), n_tf1=3DDocValuesFormat(name=3DDirect), n_tdt1=3DDocValue= sFormat(name=3DDirect), id_i1=3DDocValuesFormat(name=3DLucene80), range_fac= et_i_dv=3DDocValuesFormat(name=3DDirect), intDvoDefault=3DDocValuesFormat(n= ame=3DAsserting), timestamp=3DDocValuesFormat(name=3DDirect)}, maxPointsInL= eafNode=3D331, maxMBSortInHeap=3D5.416228246022857, sim=3DAsserting(org.apa= che.lucene.search.similarities.AssertingSimilarity@2f812af6), locale=3Dcu, = timezone=3DAtlantic/Madeira [junit4] 2> NOTE: Linux 4.18.0-17-generic amd64/Oracle Corporation 11.= 0.2 (64-bit)/cpus=3D8,threads=3D1,free=3D304630648,total=3D526909440 [junit4] 2> NOTE: All tests run in this JVM: [TestFieldResource, TestS= chemalessBufferedUpdates, TestUseDocValuesAsStored2, TestSQLHandler, SolrPl= uginUtilsTest, TestHighlightDedupGrouping, ChaosMonkeyNothingIsSafeWithPull= ReplicasTest, QueryParsingTest, DistributedExpandComponentTest, NodeLostTri= ggerTest, TestAuthorizationFramework, PreAnalyzedUpdateProcessorTest, TestX= IncludeConfig, TestConfigSetsAPIExclusivity, ReplicationFactorTest, DisMaxR= equestHandlerTest, TestCoreContainer, TestJsonRequest, TestSolrConfigHandle= rConcurrent, TestSizeLimitedDistributedMap, StatsComponentTest, TestFacetMe= thods, TokenizerChainTest, TestDocTermOrdsUninvertLimit, CollectionStateFor= mat2Test, SoftAutoCommitTest, TestSort, MultiDestinationAuditLoggerTest, Te= stCloudInspectUtil, TestNumericTokenStream, TestPushWriter, TestLeaderElect= ionWithEmptyReplica, Tagger2Test, BadCopyFieldTest, AnalyticsQueryTest, Tes= tReplicationHandlerDiskOverFlow, ShardRoutingTest, TestRandomRequestDistrib= ution, MultiThreadedOCPTest, TestSimComputePlanAction, HdfsNNFailoverTest, = TestFuzzyAnalyzedSuggestions, SolrCLIZkUtilsTest, TestIndexingPerformance, = TestDownShardTolerantSearch, TestSolr4Spatial, SuggesterWFSTTest, TestCodec= Support, LeaderFailureAfterFreshStartTest, TestBulkSchemaConcurrent, Recove= ryAfterSoftCommitTest, TestBM25SimilarityFactory, TestExactSharedStatsCache= , TestWriterPerf, TestRestManager, TestRealTimeGet, DateFieldTest, ScriptEn= gineTest, DocValuesMultiTest, ResponseHeaderTest, DocValuesNotIndexedTest, = FullHLLTest, DirectSolrConnectionTest, BasicDistributedZkTest, LargeFieldTe= st, AtomicUpdateRemovalJavabinTest, MoveReplicaHDFSTest, CollectionTooManyR= eplicasTest, TestDistributedStatsComponentCardinality, TestTolerantUpdatePr= ocessorCloud, TestDistributedSearch, ExternalFileFieldSortTest, IgnoreLarge= DocumentProcessorFactoryTest, TestDynamicURP, TestValueSourceCache, Exitabl= eDirectoryReaderTest, SolrCloudReportersTest, TestSolrCLIRunExample, Schema= ApiFailureTest, DeleteStatusTest, TestCollectionsAPIViaSolrCloudCluster, St= atelessScriptUpdateProcessorFactoryTest, AnalysisErrorHandlingTest, Distrib= utedFacetPivotWhiteBoxTest, TestMergePolicyConfig, SSLMigrationTest, Resour= ceLoaderTest, CreateRoutedAliasTest, TestSolrCloudWithHadoopAuthPlugin, Pee= rSyncWithLeaderAndIndexFingerprintCachingTest, JSONWriterTest, ZkNodePropsT= est, SplitShardTest, AutoAddReplicasPlanActionTest, TestReload, StatsReload= RaceTest, SpellCheckCollatorTest, AdminHandlersProxyTest, TestCloudPseudoRe= turnFields, RemoteQueryErrorTest, CdcrBidirectionalTest, OutOfBoxZkACLAndCr= edentialsProvidersTest, TestSolrCloudWithKerberosAlt, TestConfigSetImmutabl= e, RegexBytesRefFilterTest, CdcrReplicationHandlerTest, XmlInterpolationTes= t, LeaderElectionIntegrationTest, TestCloudSearcherWarming, TestLuceneMatch= Version, TestLMJelinekMercerSimilarityFactory, ConnectionReuseTest, SparseH= LLTest, TestHashQParserPlugin, OverseerModifyCollectionTest, TestCustomStre= am, BlockJoinFacetSimpleTest, TestExceedMaxTermLength, BasicAuthStandaloneT= est, TermVectorComponentDistributedTest, TestCollectionAPIs, TestWithCollec= tion, TestFiltering, LegacyCloudClusterPropTest, TestQuerySenderNoQuery, Si= gnificantTermsQParserPluginTest, TestStressRecovery, SearchRateTriggerInteg= rationTest, MetricsHandlerTest, TestRemoteStreaming, ConfigureRecoveryStrat= egyTest, TestFieldCacheWithThreads, TestDocSet, ShardsWhitelistTest, Overse= erTaskQueueTest, TestTolerantSearch, BasicFunctionalityTest, EchoParamsTest= , MinimalSchemaTest, OutputWriterTest, SampleTest, SolrInfoBeanTest, SolrTe= stCaseJ4Test, TestCrossCoreJoin, TestCursorMarkWithoutUniqueKey, TestDistri= butedGrouping, TestRandomDVFaceting, TestSimpleTrackingShardHandler, PathHi= erarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, TestCharFilter= s, TestEmbeddedSolrServerAdminHandler, TestEmbeddedSolrServerConstructors, = TestEmbeddedSolrServerSchemaAPI, AddReplicaTest, AssignBackwardCompatibilit= yTest, CloudExitableDirectoryReaderTest, ClusterStateTest, ClusterStateUpda= teTest, ConcurrentCreateRoutedAliasTest, ConfigSetsAPITest, ConnectionManag= erTest, DeleteNodeTest, DistribDocExpirationUpdateProcessorTest, DistribJoi= nFromCollectionTest, ForceLeaderWithTlogReplicasTest, FullSolrCloudDistribC= mdsTest, HealthCheckHandlerTest, HttpPartitionTest, MissingSegmentRecoveryT= est, SystemCollectionCompatTest, TestPullReplica, TestPullReplicaErrorHandl= ing, TestStressInPlaceUpdates, ZkCLITest, CollectionsAPIDistributedZkTest, = TestRequestStatusCollectionAPI, ExecutePlanActionTest, HdfsAutoAddReplicasI= ntegrationTest, HttpTriggerListenerTest, IndexSizeTriggerTest, MetricTrigge= rIntegrationTest, NodeAddedTriggerTest, ScheduledMaintenanceTriggerTest, Sc= heduledTriggerIntegrationTest, SystemLogListenerTest, TriggerCooldownIntegr= ationTest, TestSimDistributedQueue, TestSimExecutePlanAction, TestSimExtrem= eIndexing, TestSimGenericDistributedQueue, TestSimNodeAddedTrigger, TestSim= NodeLostTrigger, TestSimPolicyCloud, TestSimTriggerIntegration, CdcrVersion= ReplicationTest, CdcrWithNodesRestartsTest, HDFSCollectionsAPITest, Alterna= teDirectoryTest, PluginInfoTest, QueryResultKeyTest, RAMDirectoryFactoryTes= t, SolrCoreCheckLockOnStartupTest, SolrCoreTest, TestSimpleTextCodec, TestS= olrDeletionPolicy1, TestSolrDeletionPolicy2, TestSolrIndexConfig, TestSolrC= loudSnapshots, TestCoreBackup, TestHdfsBackupRestoreCore, CoreMergeIndexesA= dminHandlerTest, InfoHandlerTest, LoggingHandlerTest, LukeRequestHandlerTes= t, PropertiesRequestHandlerTest, SecurityConfHandlerTest, TestCoreAdminApis= , ZookeeperStatusHandlerTest, CustomHighlightComponentTest, DebugComponentT= est, DistributedFacetPivotLargeTest, DistributedFacetPivotSmallAdvancedTest= , DistributedQueryComponentOptimizationTest, DistributedSuggestComponentTes= t, DistributedTermsComponentTest, QueryElevationComponentTest, TestHttpShar= dHandlerFactory, TestTrackingShardHandlerFactory, TestLegacyField, TestLega= cyNumericUtils, TestNumericRangeQuery32, SolrGraphiteReporterTest, TestBina= ryResponseWriter, TestCSVResponseWriter, TestCustomDocTransformer, TestGeoJ= SONResponseWriter, TestGraphMLResponseWriter, TestSolrQueryResponse, TestCh= ildDocTransformer, TestSubQueryTransformer, TestSubQueryTransformerDistrib,= TestUniqueKeyFieldResource, TestManagedSynonymFilterFactory, ChangedSchema= MergeTest, ManagedSchemaRoundRobinCloudTest, SynonymTokenizerTest, TestClou= dSchemaless, TestMaxScoreQueryParser, TestMissingGroups, TestPayloadCheckQP= arserPlugin, TestPseudoReturnFields, TestQueryUtils, TestRangeQuery, TestCl= oudJSONFacetJoinDomain, TestJsonFacets, DocumentBuilderTest, MaxSizeAutoCom= mitTest, PeerSyncTest] [junit4] Completed [855/855 (4!)] on J1 in 138.40s, 1 test, 1 failure <<= < FAILURES! [...truncated 19904 lines...] -check-forbidden-all: [forbidden-apis] Reading bundled API signatures: jdk-unsafe-11 [forbidden-apis] Reading bundled API signatures: jdk-deprecated-11 [forbidden-apis] Reading bundled API signatures: jdk-non-portable [forbidden-apis] Reading bundled API signatures: jdk-reflection [forbidden-apis] Reading API signatures: /home/jenkins/workspace/Lucene-Sol= r-master-Linux/lucene/tools/forbiddenApis/base.txt [forbidden-apis] Reading API signatures: /home/jenkins/workspace/Lucene-Sol= r-master-Linux/lucene/tools/forbiddenApis/lucene.txt [forbidden-apis] Loading classes to check... [forbidden-apis] Scanning classes for violations... [forbidden-apis] Forbidden method invocation: java.lang.String#format(java.= lang.String,java.lang.Object[]) [Uses default locale] [forbidden-apis] in org.apache.lucene.queries.mlt.TestMoreLikeThis (TestM= oreLikeThis.java:497) [forbidden-apis] Scanned 239 class file(s) for forbidden API invocations (i= n 0.07s), 1 error(s). BUILD FAILED /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:634: The followi= ng error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/build.xml:117: The followi= ng error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/build.xml:119: The = following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:21= 80: The following error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-master-Linux/lucene/common-build.xml:23= 55: Check for forbidden API calls failed, see log. Total time: 81 minutes 49 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 [WARNINGS] Skipping publisher since build result is FAILURE Recording test results Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Email was triggered for: Failure - Any Sending email for trigger: Failure - Any Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 Setting ANT_1_8_2_HOME=3D/home/jenkins/tools/hudson.tasks.Ant_AntInstallati= on/ANT_1.8.2 ------=_Part_38_1623113885.1556711732287 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_38_1623113885.1556711732287--