From dev-return-354532-archive-asf-public=cust-asf.ponee.io@lucene.apache.org Wed May 1 05:10:11 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 3F309180651 for ; Wed, 1 May 2019 07:10:10 +0200 (CEST) Received: (qmail 43219 invoked by uid 500); 1 May 2019 05:10:08 -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 43207 invoked by uid 99); 1 May 2019 05:10:08 -0000 Received: from pnap-us-west-generic-nat.apache.org (HELO spamd4-us-west.apache.org) (209.188.14.142) by apache.org (qpsmtpd/0.29) with ESMTP; Wed, 01 May 2019 05:10:08 +0000 Received: from localhost (localhost [127.0.0.1]) by spamd4-us-west.apache.org (ASF Mail Server at spamd4-us-west.apache.org) with ESMTP id 05D90C2D40 for ; Wed, 1 May 2019 05:10:07 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd4-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 (spamd4-us-west.apache.org [10.40.0.11]) (amavisd-new, port 10024) with ESMTP id h25ncO3YcnGB for ; Wed, 1 May 2019 05:09:59 +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 3BA5A5F3B1 for ; Wed, 1 May 2019 05:09:59 +0000 (UTC) Received: from serv1 (ip6-localhost [IPv6:::1]) by serv1.sd-datasolutions.de (Postfix) with ESMTP id 9477F10800DF for ; Wed, 1 May 2019 05:09:58 +0000 (UTC) Date: Wed, 1 May 2019 05:08:59 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org Message-ID: <1870212900.27.1556687398609.JavaMail.jenkins@serv1.sd-datasolutions.de> In-Reply-To: <2086014340.19.1556673472890.JavaMail.jenkins@serv1.sd-datasolutions.de> References: <2086014340.19.1556673472890.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS] Lucene-Solr-8.x-Linux (32bit/jdk1.8.0_201) - Build # 493 - Still Failing! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_26_876954837.1556687398548" X-Jenkins-Job: Lucene-Solr-8.x-Linux X-Jenkins-Result: FAILURE ------=_Part_26_876954837.1556687398548 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/493/ Java: 32bit/jdk1.8.0_201 -client -XX:+UseConcMarkSweepGC 2 tests failed. 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:38107/_ox/s/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:38107/= _ox/s/collection1 =09at __randomizedtesting.SeedInfo.seed([977B0D8549419591:1F2F325FE7BDF869]= :0) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2700) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2689) =09at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:62) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:43) =09at java.lang.reflect.Method.invoke(Method.java:498) =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 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.lang.Thread.run(Thread.java:748) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurr= ed while waiting response from server at: http://127.0.0.1:38107/_ox/s/coll= ection1 =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:2695) =09... 43 more Caused by: java.net.SocketTimeoutException: Read timed out =09at java.net.SocketInputStream.socketRead0(Native Method) =09at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) =09at java.net.SocketInputStream.read(SocketInputStream.java:171) =09at java.net.SocketInputStream.read(SocketInputStream.java:141) =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... 50 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:34505/ws/eb/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:34505/= ws/eb/collection1 =09at __randomizedtesting.SeedInfo.seed([977B0D8549419591:1F2F325FE7BDF869]= :0) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2700) =09at org.apache.lucene.util.LuceneTestCase.expectThrows(LuceneTestCase.jav= a:2689) =09at org.apache.solr.update.PeerSyncTest.test(PeerSyncTest.java:279) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:62) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:43) =09at java.lang.reflect.Method.invoke(Method.java:498) =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 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.lang.Thread.run(Thread.java:748) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occurr= ed while waiting response from server at: http://127.0.0.1:34505/ws/eb/coll= ection1 =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:2695) =09... 43 more Caused by: java.net.SocketTimeoutException: Read timed out =09at java.net.SocketInputStream.socketRead0(Native Method) =09at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) =09at java.net.SocketInputStream.read(SocketInputStream.java:171) =09at java.net.SocketInputStream.read(SocketInputStream.java:141) =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... 50 more Build Log: [...truncated 14643 lines...] [junit4] Suite: org.apache.solr.update.PeerSyncTest [junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-= Linux/solr/build/solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549= 419591-001/init-core-data-001 [junit4] 2> 2478323 WARN (SUITE-PeerSyncTest-seed#[977B0D8549419591]-= worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=3D18 n= umCloses=3D18 [junit4] 2> 2478323 INFO (SUITE-PeerSyncTest-seed#[977B0D8549419591]-= worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPR= OP=3Dtrue) w/NUMERIC_DOCVALUES_SYSPROP=3Dtrue [junit4] 2> 2478328 INFO (SUITE-PeerSyncTest-seed#[977B0D8549419591]-= worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (= false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=3Dhttps://is= sues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 2478328 INFO (SUITE-PeerSyncTest-seed#[977B0D8549419591]-= worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.a= llowed.securerandom=3Dnull & java.security.egd=3Dfile:/dev/./urandom [junit4] 2> 2478329 INFO (SUITE-PeerSyncTest-seed#[977B0D8549419591]-= worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext syst= em property: /_ox/s [junit4] 2> 2478329 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 ####initCore [junit4] 2> 2478330 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, = from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/te= st-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linu= x/solr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2478367 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2478456 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.IndexSchema [null] Schema name=3Dtest [junit4] 2> 2478766 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field = id [junit4] 2> 2481546 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: W= hitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3D= false] [junit4] 2> 2481561 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@1e84e00[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2481567 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@1ff35e3[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2481890 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cach= e for 2147483647 transient cores [junit4] 2> 2481890 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping = metrics history in memory. [junit4] 2> 2481934 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (regis= try 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@= 1362881 [junit4] 2> 2481979 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (regist= ry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13= 62881 [junit4] 2> 2481979 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (regi= stry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServe= r@1362881 [junit4] 2> 2481982 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, fro= m paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-= files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/s= olr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2482035 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2482099 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 2482339 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2482363 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using config= uration from instancedir /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr= /core/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 2482364 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection= 1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeans= erver.JmxMBeanServer@1362881 [junit4] 2> 2482364 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/j= enkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collec= tion1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build= /solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/init-= core-data-001/] [junit4] 2> 2482367 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D766210615, maxMergeSizeForForcedMerg= e=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D2147= 483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 2482370 WARN (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] 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> 2482450 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.s= olr.update.UpdateLog [junit4] 2> 2482450 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLe= vel=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 2482454 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2482454 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2482456 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D24= , maxMergeAtOnceExplicit=3D36, maxMergedSegmentMB=3D1.03515625, floorSegmen= tMB=3D0.935546875, forceMergeDeletesPctAllowed=3D24.713105856908967, segmen= tsPerTier=3D48.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.5379262786861285, deletesPctAllowed=3D39.83104854822948 [junit4] 2> 2482456 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1dca069[collection1] m= ain] [junit4] 2> 2482457 WARN (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /h= ome/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/c= ollection1/conf; switching to use InMemory storage instead. [junit4] 2> 2482458 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2482458 INFO (coreLoadExecutor-7650-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Could not find max version in index or recent up= dates, using new clock 1632302534781566976 [junit4] 2> 2482463 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end [junit4] 2> 2482470 INFO (searcherExecutor-7651-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@1dca069[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 2482581 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenk= ins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.= update.PeerSyncTest_977B0D8549419591-001/tempDir-001/control/cores/collecti= on1 [junit4] 2> 2482582 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close ling= er time [junit4] 2> 2482587 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured po= rt=3D0) [junit4] 2> 2482587 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try= number 1 ... [junit4] 2> 2482587 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:= 31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 2482590 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 2482590 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2482590 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2482591 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@= e93145{/_ox/s,null,AVAILABLE} [junit4] 2> 2482592 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@194a55a{HTTP/= 1.1,[http/1.1, h2c]}{127.0.0.1:37051} [junit4] 2> 2482592 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server Started @2482620ms [junit4] 2> 2482592 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=3Dschema.= xml, solrconfig=3Dsolrconfig-tlog.xml, hostContext=3D/_ox/s, hostPort=3D370= 51, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/= build/solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/= tempDir-001/control/cores} [junit4] 2> 2482593 ERROR (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. L= ogging may be missing or incomplete. [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logg= ing.slf4j.Log4jLoggerFactory [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache = Solr=E2=84=A2 version 8.1.0 [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standa= lone mode on port null [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-0= 5-01T04:30:04.161Z [junit4] 2> 2482593 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /hom= e/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp= /solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/control/solr.xml [junit4] 2> 2482602 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erWorkLoopDelay is ignored [junit4] 2> 2482602 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erBadNodeExpiration is ignored [junit4] 2> 2482610 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserv= er.JmxMBeanServer@1362881, but no JMX reporters were configured - adding de= fault JMX reporter. [junit4] 2> 2485383 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: W= hitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3D= false] [junit4] 2> 2485386 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@12b898a[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2485402 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@19ff88d[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2485431 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cach= e for 4 transient cores [junit4] 2> 2485431 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping = metrics history in memory. [junit4] 2> 2485497 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (regis= try 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@= 1362881 [junit4] 2> 2485526 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (regist= ry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13= 62881 [junit4] 2> 2485527 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (regi= stry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServe= r@1362881 [junit4] 2> 2485530 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions undernea= th /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/= J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/control/c= ores [junit4] 2> 2485530 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2485533 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, fro= m paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-= files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/s= olr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2485651 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2485732 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 2486120 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2486154 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using config= uration from configset /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/c= ore/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 2486154 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection= 1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeans= erver.JmxMBeanServer@1362881 [junit4] 2> 2486155 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/j= enkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collec= tion1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build= /solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempD= ir-001/control/cores/collection1/data/] [junit4] 2> 2486158 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D766210615, maxMergeSizeForForcedMerg= e=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D2147= 483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 2486161 WARN (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] 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> 2486287 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.s= olr.update.UpdateLog [junit4] 2> 2486287 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLe= vel=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 2486292 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2486292 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2486294 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D24= , maxMergeAtOnceExplicit=3D36, maxMergedSegmentMB=3D1.03515625, floorSegmen= tMB=3D0.935546875, forceMergeDeletesPctAllowed=3D24.713105856908967, segmen= tsPerTier=3D48.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.5379262786861285, deletesPctAllowed=3D39.83104854822948 [junit4] 2> 2486294 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1abc60d[collection1] m= ain] [junit4] 2> 2486295 WARN (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /h= ome/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/c= ollection1/conf; switching to use InMemory storage instead. [junit4] 2> 2486295 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2486296 INFO (coreLoadExecutor-7664-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Could not find max version in index or recent up= dates, using new clock 1632302538806001664 [junit4] 2> 2486325 INFO (searcherExecutor-7665-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@1abc60d[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 2486448 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenk= ins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.= update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard0/cores/collectio= n1 [junit4] 2> 2486449 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close ling= er time [junit4] 2> 2486450 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured po= rt=3D0) [junit4] 2> 2486450 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try= number 1 ... [junit4] 2> 2486450 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:= 31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 2486467 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 2486467 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2486467 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2486472 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@= 12ec56f{/_ox/s,null,AVAILABLE} [junit4] 2> 2486474 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@ead0ac{HTTP/1= .1,[http/1.1, h2c]}{127.0.0.1:38107} [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server Started @2486502ms [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=3Dschema.= xml, solrconfig=3Dsolrconfig-tlog.xml, hostContext=3D/_ox/s, hostPort=3D381= 07, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/= build/solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/= tempDir-001/shard0/cores} [junit4] 2> 2486475 ERROR (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. L= ogging may be missing or incomplete. [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logg= ing.slf4j.Log4jLoggerFactory [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache = Solr=E2=84=A2 version 8.1.0 [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standa= lone mode on port null [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2486475 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-0= 5-01T04:30:08.043Z [junit4] 2> 2486476 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /hom= e/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp= /solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard0/solr.xml [junit4] 2> 2486494 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erWorkLoopDelay is ignored [junit4] 2> 2486495 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erBadNodeExpiration is ignored [junit4] 2> 2486517 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserv= er.JmxMBeanServer@1362881, but no JMX reporters were configured - adding de= fault JMX reporter. [junit4] 2> 2490090 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: W= hitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3D= false] [junit4] 2> 2490094 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@16b9a94[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2490100 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@166f959[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2490123 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cach= e for 4 transient cores [junit4] 2> 2490124 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping = metrics history in memory. [junit4] 2> 2490156 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (regis= try 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@= 1362881 [junit4] 2> 2490196 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (regist= ry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13= 62881 [junit4] 2> 2490197 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (regi= stry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServe= r@1362881 [junit4] 2> 2490200 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions undernea= th /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/= J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard0/co= res [junit4] 2> 2490200 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2490201 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, fro= m paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-= files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/s= olr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2490331 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2490434 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 2490733 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2490752 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using config= uration from configset /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/c= ore/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 2490753 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection= 1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeans= erver.JmxMBeanServer@1362881 [junit4] 2> 2490753 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/j= enkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collec= tion1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build= /solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempD= ir-001/shard0/cores/collection1/data/] [junit4] 2> 2490755 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D766210615, maxMergeSizeForForcedMerg= e=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D2147= 483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 2490760 WARN (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] 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> 2490845 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.s= olr.update.UpdateLog [junit4] 2> 2490845 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLe= vel=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 2490846 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2490846 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2490854 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D24= , maxMergeAtOnceExplicit=3D36, maxMergedSegmentMB=3D1.03515625, floorSegmen= tMB=3D0.935546875, forceMergeDeletesPctAllowed=3D24.713105856908967, segmen= tsPerTier=3D48.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.5379262786861285, deletesPctAllowed=3D39.83104854822948 [junit4] 2> 2490855 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1e8363d[collection1] m= ain] [junit4] 2> 2490856 WARN (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /h= ome/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/c= ollection1/conf; switching to use InMemory storage instead. [junit4] 2> 2490856 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2490856 INFO (coreLoadExecutor-7678-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Could not find max version in index or recent up= dates, using new clock 1632302543587508224 [junit4] 2> 2490860 INFO (searcherExecutor-7679-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@1e8363d[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 2490957 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenk= ins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.= update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard1/cores/collectio= n1 [junit4] 2> 2490957 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close ling= er time [junit4] 2> 2490958 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured po= rt=3D0) [junit4] 2> 2490958 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try= number 1 ... [junit4] 2> 2490958 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:= 31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 2490959 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 2490959 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2490959 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session node0 Scavenging every 600000ms [junit4] 2> 2490959 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@= 426b92{/_ox/s,null,AVAILABLE} [junit4] 2> 2490960 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@111ca6f{HTTP/= 1.1,[http/1.1, h2c]}{127.0.0.1:34629} [junit4] 2> 2490960 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server Started @2490988ms [junit4] 2> 2490960 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=3Dschema.= xml, solrconfig=3Dsolrconfig-tlog.xml, hostContext=3D/_ox/s, hostPort=3D346= 29, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/= build/solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/= tempDir-001/shard1/cores} [junit4] 2> 2490961 ERROR (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. L= ogging may be missing or incomplete. [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logg= ing.slf4j.Log4jLoggerFactory [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache = Solr=E2=84=A2 version 8.1.0 [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standa= lone mode on port null [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-0= 5-01T04:30:12.529Z [junit4] 2> 2490961 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /hom= e/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp= /solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard1/solr.xml [junit4] 2> 2490972 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erWorkLoopDelay is ignored [junit4] 2> 2490972 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erBadNodeExpiration is ignored [junit4] 2> 2490977 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserv= er.JmxMBeanServer@1362881, but no JMX reporters were configured - adding de= fault JMX reporter. [junit4] 2> 2492029 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: W= hitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3D= false] [junit4] 2> 2492038 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@1d8d10e[provider=3Dnull,keyStore=3Dnull,trus= tStore=3Dnull] [junit4] 2> 2492047 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@b7750d[provider=3Dnull,keyStore=3Dnull,trust= Store=3Dnull] [junit4] 2> 2492078 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cach= e for 4 transient cores [junit4] 2> 2492078 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping = metrics history in memory. [junit4] 2> 2492125 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (regis= try 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@= 1362881 [junit4] 2> 2492150 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (regist= ry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13= 62881 [junit4] 2> 2492150 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (regi= stry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServe= r@1362881 [junit4] 2> 2492158 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions undernea= th /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/= J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard1/co= res [junit4] 2> 2492158 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2492159 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, fro= m paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-= files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/s= olr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2492263 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2492370 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 2492711 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2492744 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using config= uration from configset /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/c= ore/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 2492744 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection= 1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeans= erver.JmxMBeanServer@1362881 [junit4] 2> 2492745 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/j= enkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collec= tion1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build= /solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempD= ir-001/shard1/cores/collection1/data/] [junit4] 2> 2492748 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D766210615, maxMergeSizeForForcedMerg= e=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D2147= 483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 2492773 WARN (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] 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> 2492862 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.s= olr.update.UpdateLog [junit4] 2> 2492862 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLe= vel=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 2492863 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2492863 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2492891 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D24= , maxMergeAtOnceExplicit=3D36, maxMergedSegmentMB=3D1.03515625, floorSegmen= tMB=3D0.935546875, forceMergeDeletesPctAllowed=3D24.713105856908967, segmen= tsPerTier=3D48.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.5379262786861285, deletesPctAllowed=3D39.83104854822948 [junit4] 2> 2492892 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@145fc48[collection1] m= ain] [junit4] 2> 2492892 WARN (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /h= ome/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/c= ollection1/conf; switching to use InMemory storage instead. [junit4] 2> 2492893 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2492893 INFO (coreLoadExecutor-7692-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Could not find max version in index or recent up= dates, using new clock 1632302545723457536 [junit4] 2> 2492901 INFO (searcherExecutor-7693-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@145fc48[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader())} [junit4] 2> 2493007 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /home/jenk= ins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.= update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard2/cores/collectio= n1 [junit4] 2> 2493008 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close ling= er time [junit4] 2> 2493008 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured po= rt=3D0) [junit4] 2> 2493008 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try= number 1 ... [junit4] 2> 2493008 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:= 31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 2493010 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 2493010 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session No SessionScavenger set, using defaults [junit4] 2> 2493010 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.session node0 Scavenging every 660000ms [junit4] 2> 2493010 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@= 1f31c78{/_ox/s,null,AVAILABLE} [junit4] 2> 2493011 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@c20109{HTTP/1= .1,[http/1.1, h2c]}{127.0.0.1:45949} [junit4] 2> 2493011 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.s.Server Started @2493039ms [junit4] 2> 2493011 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {schema=3Dschema.= xml, solrconfig=3Dsolrconfig-tlog.xml, hostContext=3D/_ox/s, hostPort=3D459= 49, coreRootDirectory=3D/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/= build/solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/= tempDir-001/shard2/cores} [junit4] 2> 2493012 ERROR (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. L= ogging may be missing or incomplete. [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logg= ing.slf4j.Log4jLoggerFactory [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache = Solr=E2=84=A2 version 8.1.0 [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in standa= lone mode on port null [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-0= 5-01T04:30:14.580Z [junit4] 2> 2493012 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /hom= e/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp= /solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard2/solr.xml [junit4] 2> 2493021 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erWorkLoopDelay is ignored [junit4] 2> 2493021 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailov= erBadNodeExpiration is ignored [junit4] 2> 2493035 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserv= er.JmxMBeanServer@1362881, but no JMX reporters were configured - adding de= fault JMX reporter. [junit4] 2> 2494467 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: W= hitelistHostChecker [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3D= false] [junit4] 2> 2494470 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@5862ef[provider=3Dnull,keyStore=3Dnull,trust= Store=3Dnull] [junit4] 2> 2494476 WARN (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm co= nfigured for SslContextFactory@23786f[provider=3Dnull,keyStore=3Dnull,trust= Store=3Dnull] [junit4] 2> 2494513 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cach= e for 4 transient cores [junit4] 2> 2494513 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping = metrics history in memory. [junit4] 2> 2494556 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (regis= try 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@= 1362881 [junit4] 2> 2494581 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (regist= ry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@13= 62881 [junit4] 2> 2494582 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (regi= stry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServe= r@1362881 [junit4] 2> 2494588 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions undernea= th /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/= J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempDir-001/shard2/co= res [junit4] 2> 2494588 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1] [junit4] 2> 2494588 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, fro= m paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-= files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/s= olr/core/src/test-files/solr/collection1/lib/classes] [junit4] 2> 2494641 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0 [junit4] 2> 2494724 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema [collection1] Schema name=3Dtest [junit4] 2> 2494963 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id [junit4] 2> 2494981 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using config= uration from configset /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/c= ore/src/test-files/solr/collection1, trusted=3Dtrue [junit4] 2> 2494982 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection= 1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeans= erver.JmxMBeanServer@1362881 [junit4] 2> 2494991 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/j= enkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collec= tion1], dataDir=3D[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build= /solr-core/test/J1/temp/solr.update.PeerSyncTest_977B0D8549419591-001/tempD= ir-001/shard2/cores/collection1/data/] [junit4] 2> 2494994 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize= =3D0, mergeFactor=3D10, maxMergeSize=3D766210615, maxMergeSizeForForcedMerg= e=3D9223372036854775807, calibrateSizeByDeletes=3Dtrue, maxMergeDocs=3D2147= 483647, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D0.1] [junit4] 2> 2494997 WARN (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] 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> 2495087 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.s= olr.update.UpdateLog [junit4] 2> 2495087 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=3D defaultSyncLe= vel=3DFLUSH numRecordsToKeep=3D100 maxNumLogsToKeep=3D10 numVersionBuckets= =3D65536 [junit4] 2> 2495093 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 2495093 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 2495095 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apa= che.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=3D24= , maxMergeAtOnceExplicit=3D36, maxMergedSegmentMB=3D1.03515625, floorSegmen= tMB=3D0.935546875, forceMergeDeletesPctAllowed=3D24.713105856908967, segmen= tsPerTier=3D48.0, maxCFSSegmentSizeMB=3D8.796093022207999E12, noCFSRatio=3D= 0.5379262786861285, deletesPctAllowed=3D39.83104854822948 [junit4] 2> 2495095 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@b8631a[collection1] ma= in] [junit4] 2> 2495096 WARN (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /h= ome/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/c= ollection1/conf; switching to use InMemory storage instead. [junit4] 2> 2495096 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms. [junit4] 2> 2495096 INFO (coreLoadExecutor-7706-thread-1) [ x:coll= ection1] o.a.s.u.UpdateLog Could not find max version in index or recent up= dates, using new clock 1632302548033470464 [junit4] 2> 2495099 INFO (TEST-PeerSyncTest.test-seed#[977B0D85494195= 91]) [ ] o.a.s.SolrTestCaseJ4 ###Starting test [junit4] 2> 2495108 INFO (searcherExecutor-7707-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@b8631a[collection1] main{ExitableDirectoryReader(Uni= nvertingDirectoryReader())} [junit4] 2> 2495113 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[1= (1)]} 0 3 [junit4] 2> 2495116 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D START replicas=3D[http://1= 27.0.0.1:38107/_ox/s/collection1] nUpdates=3D100 [junit4] 2> 2495127 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@4db0cb[collection1] realtime] [junit4] 2> 2495127 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:8.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, versions= Hash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 2495128 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D9 [junit4] 2> 2495129 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D0, maxInHash=3D0, versions= Hash=3D0, numVersions=3D0, numDocs=3D0, maxDoc=3D0} [junit4] 2> 2495129 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D DONE. We have no versions= . sync failed. [junit4] 2> 2495131 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, versions= Hash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 2495131 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&fingerprint=3Dtrue&getVersions=3D100&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D0 [junit4] 2> 2495132 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{qt=3D/ge= t&getVersions=3D100&sync=3Dhttp://127.0.0.1:38107/_ox/s/collection1&wt=3Dja= vabin&version=3D2} status=3D0 QTime=3D16 [junit4] 2> 2495135 INFO (qtp16722046-25594) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[1= (1)]} 0 1 [junit4] 2> 2495137 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D START replicas=3D[http://1= 27.0.0.1:38107/_ox/s/collection1] nUpdates=3D100 [junit4] 2> 2495139 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, versions= Hash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 2495139 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D0 [junit4] 2> 2495151 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@4c78d8[collection1] realtime] [junit4] 2> 2495151 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:12.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, version= sHash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 2495152 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync We are already in sync. No need to do a PeerSync=20 [junit4] 2> 2495152 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{qt=3D/ge= t&getVersions=3D100&sync=3Dhttp://127.0.0.1:38107/_ox/s/collection1&wt=3Dja= vabin&version=3D2} status=3D0 QTime=3D15 [junit4] 2> 2495154 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 start commit{_version_=3D1632302548094287872,optim= ize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse,= softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 2495154 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.So= lrIndexWriter@cfa0e9 commitCommandVersion:1632302548094287872 [junit4] 2> 2495155 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@19d209a[collection1] main] [junit4] 2> 2495156 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2495162 INFO (searcherExecutor-7679-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@19d209a[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics=3D{os=3DLinu= x, java.vendor=3DOracle Corporation, java.version=3D1.8.0_201, java.vm.vers= ion=3D25.201-b09, lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.vers= ion=3D1.8.0_201-b09, source=3Dflush, os.version=3D4.18.0-17-generic, timest= amp=3D1556685016691}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST= _SPEED}])))} [junit4] 2> 2495163 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djava= bin&version=3D2}{commit=3D} 0 9 [junit4] 2> 2495164 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 start commit{_version_=3D1632302548104773632,optim= ize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse,= softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 2495165 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.So= lrIndexWriter@2c1f8f commitCommandVersion:1632302548104773632 [junit4] 2> 2495166 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@1dac267[collection1] main] [junit4] 2> 2495167 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2495171 INFO (searcherExecutor-7693-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@1dac267[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics=3D{os=3DLinu= x, java.vendor=3DOracle Corporation, java.version=3D1.8.0_201, java.vm.vers= ion=3D25.201-b09, lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.vers= ion=3D1.8.0_201-b09, source=3Dflush, os.version=3D4.18.0-17-generic, timest= amp=3D1556685016715}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST= _SPEED}])))} [junit4] 2> 2495171 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djava= bin&version=3D2}{commit=3D} 0 7 [junit4] 2> 2495173 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/select params=3D{q=3D*= :*&wt=3Djavabin&version=3D2} hits=3D1 status=3D0 QTime=3D0 [junit4] 2> 2495181 INFO (qtp16722046-25594) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/select params=3D{q=3D*= :*&wt=3Djavabin&version=3D2} hits=3D1 status=3D0 QTime=3D0 [junit4] 2> 2495186 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[2= (2)]} 0 3 [junit4] 2> 2495188 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D START replicas=3D[http://1= 27.0.0.1:38107/_ox/s/collection1] nUpdates=3D100 [junit4] 2> 2495196 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@58d4bc[collection1] realtime] [junit4] 2> 2495197 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:7.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, versions= Hash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495197 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D7 [junit4] 2> 2495198 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D1, maxInHash=3D1, versions= Hash=3D-5451962507482445012, numVersions=3D1, numDocs=3D1, maxDoc=3D1} [junit4] 2> 2495199 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, versions= Hash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495199 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&fingerprint=3Dtrue&getVersions=3D100&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D0 [junit4] 2> 2495200 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D Received 2 versions from = http://127.0.0.1:38107/_ox/s/collection1 fingerprint:{maxVersionSpecified= =3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, versionsH= ash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495202 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&checkCanHandleVersionRanges=3Dfalse&wt=3Djavabin&version= =3D2} status=3D0 QTime=3D0 [junit4] 2> 2495202 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D Requesting updates from ht= tp://127.0.0.1:38107/_ox/s/collection1n=3D1 versions=3D2...2 [junit4] 2> 2495204 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D2, maxVersionEncountered=3D2, maxInHash=3D2, versionsHash=3D-1218814014= 108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495205 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{getUpdat= es=3D2...2&distrib=3Dfalse&qt=3D/get&fingerprint=3Dtrue&onlyIfActive=3Dfals= e&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1 [junit4] 2> 2495217 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] {add=3D[2 (2)]} 0 11 [junit4] 2> 2495226 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@11cbea7[collection1] realtime] [junit4] 2> 2495227 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:10.0 result:{maxVersionSpecifi= ed=3D2, maxVersionEncountered=3D2, maxInHash=3D2, versionsHash=3D-121881401= 4108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495227 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync Fingerprint comparison: 0 [junit4] 2> 2495227 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D DONE. sync succeeded [junit4] 2> 2495227 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{qt=3D/ge= t&getVersions=3D100&sync=3Dhttp://127.0.0.1:38107/_ox/s/collection1&wt=3Dja= vabin&version=3D2} status=3D0 QTime=3D39 [junit4] 2> 2495229 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 start commit{_version_=3D1632302548172931072,optim= ize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse,= softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 2495229 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.So= lrIndexWriter@cfa0e9 commitCommandVersion:1632302548172931072 [junit4] 2> 2495231 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@18fd15f[collection1] main] [junit4] 2> 2495231 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2495240 INFO (searcherExecutor-7679-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@18fd15f[collection1] main{ExitableDirectoryReader(Un= invertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics=3D{os=3DLinu= x, java.vendor=3DOracle Corporation, java.version=3D1.8.0_201, java.vm.vers= ion=3D25.201-b09, lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.vers= ion=3D1.8.0_201-b09, source=3Dflush, os.version=3D4.18.0-17-generic, timest= amp=3D1556685016691}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST= _SPEED}]) Uninverting(_1(8.1.0):C1:[diagnostics=3D{os=3DLinux, java.vendor= =3DOracle Corporation, java.version=3D1.8.0_201, java.vm.version=3D25.201-b= 09, lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.version=3D1.8.0_20= 1-b09, source=3Dflush, os.version=3D4.18.0-17-generic, timestamp=3D15566850= 16761}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST_SPEED}])))} [junit4] 2> 2495241 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djava= bin&version=3D2}{commit=3D} 0 12 [junit4] 2> 2495242 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 start commit{_version_=3D1632302548186562560,optim= ize=3Dfalse,openSearcher=3Dtrue,waitSearcher=3Dtrue,expungeDeletes=3Dfalse,= softCommit=3Dfalse,prepareCommit=3Dfalse} [junit4] 2> 2495242 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.So= lrIndexWriter@2c1f8f commitCommandVersion:1632302548186562560 [junit4] 2> 2495244 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@2480e[collection1] main] [junit4] 2> 2495245 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.DirectUpdateHandler2 end_commit_flush [junit4] 2> 2495250 INFO (searcherExecutor-7693-thread-1-processing-x= :collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered= new searcher Searcher@2480e[collection1] main{ExitableDirectoryReader(Unin= vertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics=3D{os=3DLinux,= java.vendor=3DOracle Corporation, java.version=3D1.8.0_201, java.vm.versio= n=3D25.201-b09, lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.versio= n=3D1.8.0_201-b09, source=3Dflush, os.version=3D4.18.0-17-generic, timestam= p=3D1556685016715}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST_S= PEED}]) Uninverting(_1(8.1.0):C1:[diagnostics=3D{os=3DLinux, java.vendor=3D= Oracle Corporation, java.version=3D1.8.0_201, java.vm.version=3D25.201-b09,= lucene.version=3D8.1.0, os.arch=3Di386, java.runtime.version=3D1.8.0_201-b= 09, source=3Dflush, os.version=3D4.18.0-17-generic, timestamp=3D15566850167= 90}]:[attributes=3D{Lucene50StoredFieldsFormat.mode=3DBEST_SPEED}])))} [junit4] 2> 2495251 INFO (qtp16722046-25593) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{waitSearcher=3Dtrue&commit=3Dtrue&softCommit=3Dfalse&wt=3Djava= bin&version=3D2}{commit=3D} 0 8 [junit4] 2> 2495252 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/select params=3D{q=3D*= :*&wt=3Djavabin&version=3D2} hits=3D2 status=3D0 QTime=3D0 [junit4] 2> 2495255 INFO (qtp16722046-25594) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/select params=3D{q=3D*= :*&wt=3Djavabin&version=3D2} hits=3D2 status=3D0 QTime=3D0 [junit4] 2> 2495261 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[3= (3)]} 0 2 [junit4] 2> 2495264 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[4= (4)]} 0 1 [junit4] 2> 2495267 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[5= (5)]} 0 1 [junit4] 2> 2495270 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[6= (6)]} 0 1 [junit4] 2> 2495273 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[7= (7)]} 0 1 [junit4] 2> 2495276 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[8= (8)]} 0 1 [junit4] 2> 2495278 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[9= (9)]} 0 1 [junit4] 2> 2495281 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] webapp=3D/_ox/s path=3D/upda= te params=3D{update.distrib=3DFROMLEADER&wt=3Djavabin&version=3D2}{add=3D[1= 0 (10)]} 0 1 [junit4] 2> 2495282 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D START replicas=3D[http://1= 27.0.0.1:38107/_ox/s/collection1] nUpdates=3D100 [junit4] 2> 2495300 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@10e3eba[collection1] realtime] [junit4] 2> 2495301 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:17.0 result:{maxVersionSpecifi= ed=3D9223372036854775807, maxVersionEncountered=3D10, maxInHash=3D10, versi= onsHash=3D-5671163287542876028, numVersions=3D10, numDocs=3D10, maxDoc=3D8} [junit4] 2> 2495301 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&getFingerprint=3D9223372036854775807&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D17 [junit4] 2> 2495302 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D2, maxInHash=3D2, versions= Hash=3D-1218814014108643565, numVersions=3D2, numDocs=3D2, maxDoc=3D1} [junit4] 2> 2495303 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D9223372036854775807, maxVersionEncountered=3D10, maxInHash=3D10, versio= nsHash=3D-5671163287542876028, numVersions=3D10, numDocs=3D10, maxDoc=3D8} [junit4] 2> 2495304 INFO (qtp11723638-25571) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&fingerprint=3Dtrue&getVersions=3D100&wt=3Djavabin&versio= n=3D2} status=3D0 QTime=3D1 [junit4] 2> 2495304 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D Received 10 versions from= http://127.0.0.1:38107/_ox/s/collection1 fingerprint:{maxVersionSpecified= =3D9223372036854775807, maxVersionEncountered=3D10, maxInHash=3D10, version= sHash=3D-5671163287542876028, numVersions=3D10, numDocs=3D10, maxDoc=3D8} [junit4] 2> 2495305 INFO (qtp11723638-25572) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{distrib= =3Dfalse&qt=3D/get&checkCanHandleVersionRanges=3Dfalse&wt=3Djavabin&version= =3D2} status=3D0 QTime=3D0 [junit4] 2> 2495306 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D Requesting updates from ht= tp://127.0.0.1:38107/_ox/s/collection1n=3D8 versions=3D3...10 [junit4] 2> 2495308 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:0.0 result:{maxVersionSpecifie= d=3D10, maxVersionEncountered=3D10, maxInHash=3D10, versionsHash=3D-5671163= 287542876028, numVersions=3D10, numDocs=3D10, maxDoc=3D8} [junit4] 2> 2495308 INFO (qtp11723638-25573) [ x:collection1] o.a.= s.c.S.Request [collection1] webapp=3D/_ox/s path=3D/get params=3D{getUpdat= es=3D3...10&distrib=3Dfalse&qt=3D/get&fingerprint=3Dtrue&onlyIfActive=3Dfal= se&wt=3Djavabin&version=3D2} status=3D0 QTime=3D1 [junit4] 2> 2495317 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.p.LogUpdateProcessorFactory [collection1] {add=3D[3 (3), 4 (4), 5 (5), = 6 (6), 7 (7), 8 (8), 9 (9), 10 (10)]} 0 7 [junit4] 2> 2495330 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.s.SolrIndexSearcher Opening [Searcher@8a964a[collection1] realtime] [junit4] 2> 2495331 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.IndexFingerprint IndexFingerprint millis:14.0 result:{maxVersionSpecifi= ed=3D10, maxVersionEncountered=3D10, maxInHash=3D10, versionsHash=3D-567116= 3287542876028, numVersions=3D10, numDocs=3D10, maxDoc=3D8} [junit4] 2> 2495331 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync Fingerprint comparison: 0 [junit4] 2> 2495331 INFO (qtp16722046-25592) [ x:collection1] o.a.= s.u.PeerSync PeerSync: core=3Dcollection1 url=3D DONE. sync succeeded [junit4] 2>=20 [...truncated too long message...] orters for registry=3Dsolr.core.collection1, tag=3D19a64ef [junit4] 2> 3915137 INFO (coreCloseExecutor-12291-thread-1) [ x:co= llection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metr= ics.reporters.SolrJmxReporter@1337856: rootName =3D null, domain =3D solr.c= ore.collection1, service url =3D null, agent id =3D null] for registry solr= .core.collection1 / com.codahale.metrics.MetricRegistry@1e268c8 [junit4] 2> 3915141 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters= for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 3915141 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.ap= ache.solr.metrics.reporters.SolrJmxReporter@10151de: rootName =3D null, dom= ain =3D solr.node, service url =3D null, agent id =3D null] for registry so= lr.node / com.codahale.metrics.MetricRegistry@113df70 [junit4] 2> 3915141 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters= for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 3915141 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.ap= ache.solr.metrics.reporters.SolrJmxReporter@a5fa33: rootName =3D null, doma= in =3D solr.jvm, service url =3D null, agent id =3D null] for registry solr= .jvm / com.codahale.metrics.MetricRegistry@1429612 [junit4] 2> 3915142 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric reporters= for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 3915142 INFO (SUITE-PeerSyncWithLeaderTest-seed#[977B0D85= 49419591]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.ap= ache.solr.metrics.reporters.SolrJmxReporter@1aa4fad: rootName =3D null, dom= ain =3D solr.jetty, service url =3D null, agent id =3D null] for registry s= olr.jetty / com.codahale.metrics.MetricRegistry@f722a7 [junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/wo= rkspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J1/temp/solr.update= .PeerSyncWithLeaderTest_977B0D8549419591-001 [junit4] 2> NOTE: test params are: codec=3DAsserting(Lucene80): {title= _stringNoNorms=3DPostingsFormat(name=3DDirect), title_stemmed=3DPostingsFor= mat(name=3DMockRandom), multiDefault=3DPostingsFormat(name=3DMockRandom), _= root_=3DPostingsFormat(name=3DDirect), id=3DFSTOrd50, text=3DLucene50(block= size=3D128), title=3DPostingsFormat(name=3DMockRandom), title_lettertok=3DF= STOrd50}, docValues:{range_facet_l_dv=3DDocValuesFormat(name=3DDirect), _ve= rsion_=3DDocValuesFormat(name=3DAsserting), val_i_dvo=3DDocValuesFormat(nam= e=3DDirect), range_facet_i_dv=3DDocValuesFormat(name=3DAsserting), intDvoDe= fault=3DDocValuesFormat(name=3DLucene80), timestamp=3DDocValuesFormat(name= =3DAsserting)}, maxPointsInLeafNode=3D743, maxMBSortInHeap=3D7.460872513966= 815, sim=3DAsserting(org.apache.lucene.search.similarities.AssertingSimilar= ity@b053dd), locale=3Dmt-MT, timezone=3DAmerica/Bahia [junit4] 2> NOTE: Linux 4.18.0-17-generic i386/Oracle Corporation 1.8.= 0_201 (32-bit)/cpus=3D8,threads=3D1,free=3D168677304,total=3D518979584 [junit4] 2> NOTE: All tests run in this JVM: [ResourceLoaderTest, Trig= gerIntegrationTest, TestPayloadCheckQParserPlugin, TestSSLRandomization, La= rgeFieldTest, UniqFieldsUpdateProcessorFactoryTest, JavabinLoaderTest, Dist= ributedFacetPivotLongTailTest, TestSearcherReuse, TestTolerantSearch, TestH= ighlightDedupGrouping, BlockCacheTest, VersionInfoTest, TestCloudSearcherWa= rming, NodeAddedTriggerIntegrationTest, Tagger2Test, TestOrdValues, Configu= reRecoveryStrategyTest, CdcrReplicationHandlerTest, TestCursorMarkWithoutUn= iqueKey, RemoteQueryErrorTest, CdcrWithNodesRestartsTest, ConcurrentDeleteA= ndCreateCollectionTest, ClassificationUpdateProcessorFactoryTest, TestLeade= rElectionWithEmptyReplica, SchemaApiFailureTest, ShardSplitTest, BasicFunct= ionalityTest, TestUseDocValuesAsStored2, SuggesterWFSTTest, TestPullReplica= , SparseHLLTest, TransactionLogTest, SSLMigrationTest, TestJsonFacets, Test= ManagedStopFilterFactory, TestOmitPositions, CollectionTooManyReplicasTest,= TestDocSet, TestSha256AuthenticationProvider, TestLMJelinekMercerSimilarit= yFactory, AuditLoggerIntegrationTest, ZkCLITest, LeaderElectionIntegrationT= est, TestMultiValuedNumericRangeQuery, TestDynamicURP, TestLuceneMatchVersi= on, IgnoreLargeDocumentProcessorFactoryTest, TestSimExecutePlanAction, Test= RemoteStreaming, ChaosMonkeyNothingIsSafeWithPullReplicasTest, TriLevelComp= ositeIdRoutingTest, MultiThreadedOCPTest, QueryParsingTest, ExternalFileFie= ldSortTest, TestPerFieldSimilarity, TestSubQueryTransformerDistrib, TestClo= udPseudoReturnFields, TestTolerantUpdateProcessorCloud, TestCloudInspectUti= l, TestFieldCacheSort, TestExactSharedStatsCache, TestStressInPlaceUpdates,= DocValuesMultiTest, StatsComponentTest, TestNamedUpdateProcessors, TestChi= ldDocTransformerHierarchy, TestReplicationHandlerDiskOverFlow, StatelessScr= iptUpdateProcessorFactoryTest, HdfsTlogReplayBufferedWhileIndexingTest, Ord= eredExecutorTest, RegexBytesRefFilterTest, RecoveryAfterSoftCommitTest, Tes= tSolrFieldCacheBean, ShardsWhitelistTest, TestCollationField, TestMergePoli= cyConfig, FullHLLTest, TestCustomStream, DistributedQueryComponentOptimizat= ionTest, TestFieldResource, TestAddFieldRealTimeGet, TestFieldCacheWithThre= ads, BigEndianAscendingWordSerializerTest, TestAuthorizationFramework, Test= EmbeddedSolrServerConstructors, TestDistributedStatsComponentCardinality, D= irectSolrConnectionTest, ZookeeperStatusHandlerTest, TestDocTermOrdsUninver= tLimit, TestMaxScoreQueryParser, ScheduledMaintenanceTriggerTest, TestDelet= eCollectionOnDownNodes, TestSolrCLIRunExample, HighlighterMaxOffsetTest, Ci= rcularListTest, JSONWriterTest, ManagedSchemaRoundRobinCloudTest, BlockJoin= FacetSimpleTest, TestBM25SimilarityFactory, InfixSuggestersTest, TestJsonRe= quest, OutOfBoxZkACLAndCredentialsProvidersTest, ResponseHeaderTest, NodeLo= stTriggerTest, MetricsHandlerTest, TestPivotHelperCode, SolrIndexMetricsTes= t, ConnectionReuseTest, MinimalSchemaTest, ShardRoutingTest, IndexSizeTrigg= erTest, DirectSolrSpellCheckerTest, TestRandomFaceting, DisMaxRequestHandle= rTest, TestExceedMaxTermLength, TestLFUCache, FullSolrCloudDistribCmdsTest,= TestConfigSetsAPIExclusivity, TestSimpleTextCodec, TestDynamicFieldCollect= ionResource, AdminHandlersProxyTest, DistributedFacetPivotWhiteBoxTest, Tes= tSort, TestRealTimeGet, HttpPartitionTest, MetricsConfigTest, ResponseBuild= erTest, BasicDistributedZkTest, SolrCLIZkUtilsTest, DistributedExpandCompon= entTest, RulesTest, HdfsNNFailoverTest, SplitShardTest, PeerSyncTest, TestD= istributedSearch, LoggingHandlerTest, SortByFunctionTest, AssignTest, Async= CallRequestStatusResponseTest, TestCollectionsAPIViaSolrCloudCluster, AutoA= ddReplicasPlanActionTest, ComputePlanActionTest, TestSimNodeAddedTrigger, T= estSimNodeLostTrigger, TestSimPolicyCloud, TestSimTriggerIntegration, HdfsB= asicDistributedZk2Test, HdfsBasicDistributedZkTest, HdfsChaosMonkeyNothingI= sSafeTest, HdfsRecoveryZkTest, HdfsRestartWhileUpdatingTest, HdfsSyncSliceT= est, HdfsWriteToMultipleCollectionsTest, StressHdfsTest, TestClusterStateMu= tator, ZkStateReaderTest, ZkStateWriterTest, ImplicitSnitchTest, DirectoryF= actoryTest, ExitableDirectoryReaderTest, HdfsDirectoryFactoryTest, PluginIn= foTest, QueryResultKeyTest, RAMDirectoryFactoryTest, SolrCoreCheckLockOnSta= rtupTest, SolrCoreTest, TestCoreContainer, TestSolrDeletionPolicy1, TestSol= rIndexConfig, TestSolrCoreSnapshots, MoreLikeThisHandlerTest, TestBlobHandl= er, TestReplicationHandler, TermVectorComponentDistributedTest, CheckHdfsIn= dexTest, TestBulkSchemaConcurrent, TestManagedSchemaAPI, TestSortableTextFi= eld, AnalyticsQueryTest, CurrencyRangeFacetCloudTest, SignificantTermsQPars= erPluginTest, SortSpecParsingTest, TestComplexPhraseQParserPlugin, TestExte= ndedDismaxParser, TestFoldingMultitermQuery, TestGraphTermsQParserPlugin, T= estHashQParserPlugin, TestIndexSearcher, TestMultiWordSynonyms, TestNoOpReg= enerator, TestPseudoReturnFields, TestRTGBase, TestRandomCollapseQParserPlu= gin, TestReload, TestSolr4Spatial, TestSolr4Spatial2, TestStressUserVersion= s, TestStressVersions, TestTrieFacet, TestXmlQParserPlugin, RangeFacetCloud= Test, TestCloudJSONFacetJoinDomain, TestCloudJSONFacetSKG, BasicAuthIntegra= tionTest, JWTAuthPluginTest, TestImpersonationWithHadoopAuth, TestSolrCloud= WithHadoopAuthPlugin, IndexBasedSpellCheckerTest, SuggesterFSTTest, TestAna= lyzedSuggestions, TestFreeTextSuggestions, HdfsLockFactoryTest, TestNumeric= Terms32, TestUninvertingReader, AddBlockUpdateTest, AnalysisErrorHandlingTe= st, CdcrUpdateLogTest, DataDrivenBlockJoinTest, DirectUpdateHandlerTest, Pe= erSyncWithLeaderTest] [junit4] Completed [828/855 (2!)] on J1 in 147.56s, 1 test, 1 failure <<= < FAILURES! [...truncated 9064 lines...] BUILD FAILED /home/jenkins/workspace/Lucene-Solr-8.x-Linux/build.xml:634: The following = error occurred while executing this line: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/build.xml:128: Found 1 violat= ions in source files (File uses Mockito but has no assumeWorkingMockito() c= all). Total time: 137 minutes 35 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_26_876954837.1556687398548 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_26_876954837.1556687398548--