From dev-return-355063-archive-asf-public=cust-asf.ponee.io@lucene.apache.org Mon May 6 20:49:10 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 F3B3F18060F for ; Mon, 6 May 2019 22:49:08 +0200 (CEST) Received: (qmail 94528 invoked by uid 500); 6 May 2019 20:49:07 -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 94508 invoked by uid 99); 6 May 2019 20:49:07 -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; Mon, 06 May 2019 20:49:07 +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 A5126C24F6 for ; Mon, 6 May 2019 20:49:06 +0000 (UTC) X-Virus-Scanned: Debian amavisd-new at spamd4-us-west.apache.org X-Spam-Flag: NO X-Spam-Score: -0.05 X-Spam-Level: X-Spam-Status: No, score=-0.05 tagged_above=-999 required=6.31 tests=[KAM_BADIPHTTP=2, KAM_LOTSOFHASH=0.25, RCVD_IN_DNSWL_MED=-2.3, SPF_PASS=-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 MRsIZz5MOwwy for ; Mon, 6 May 2019 20:48:58 +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 9112F611DD for ; Mon, 6 May 2019 20:48:58 +0000 (UTC) Received: from serv1 (ip6-localhost [IPv6:::1]) by serv1.sd-datasolutions.de (Postfix) with ESMTP id 035E61080267 for ; Mon, 6 May 2019 20:48:58 +0000 (UTC) Date: Mon, 6 May 2019 20:45:03 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org Message-ID: <363126811.133.1557175738014.JavaMail.jenkins@serv1.sd-datasolutions.de> In-Reply-To: <2006020885.77.1556923723107.JavaMail.jenkins@serv1.sd-datasolutions.de> References: <2006020885.77.1556923723107.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS] Lucene-Solr-8.x-Solaris (64bit/jdk1.8.0) - Build # 111 - Failure! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_132_769320926.1557175737784" X-Jenkins-Job: Lucene-Solr-8.x-Solaris X-Jenkins-Result: FAILURE ------=_Part_132_769320926.1557175737784 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Solaris/111/ Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC No tests ran. Build Log: [...truncated 13015 lines...] [junit4] Suite: org.apache.solr.cloud.TestPullReplicaErrorHandling [junit4] 2> 284682 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity chec= ks: test.solr.allowed.securerandom=3Dnull & java.security.egd=3Dfile:/dev/.= /urandom [junit4] 2> Creating dataDir: /export/home/jenkins/workspace/Lucene-So= lr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestPullReplica= ErrorHandling_5366837DEF97E64E-001/init-core-data-001 [junit4] 2> 284683 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: = numOpens=3D2 numCloses=3D2 [junit4] 2> 284683 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERI= C_POINTS_SYSPROP=3Dfalse) w/NUMERIC_DOCVALUES_SYSPROP=3Dfalse [junit4] 2> 284683 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) a= nd clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugU= rl=3Dhttps://issues.apache.org/jira/browse/SOLR-5776) [junit4] 2> 284683 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster= of 4 servers in /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/sol= r/build/solr-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_5366= 837DEF97E64E-001/tempDir-001 [junit4] 2> 284687 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 284687 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTe= stServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 284687 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTe= stServer Starting server [junit4] 2> 284787 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:= 56159 [junit4] 2> 284787 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list= : 127.0.0.1:56159 [junit4] 2> 284787 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 = 56159 [junit4] 2> 284794 INFO (zkConnectionManagerCallback-1671-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284798 INFO (zkConnectionManagerCallback-1673-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284801 INFO (zkConnectionManagerCallback-1675-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284803 WARN (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 284803 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.c= .s.e.JettySolrRunner Start Jetty (original configured port=3D0) [junit4] 2> 284803 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.c= .s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 284803 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550= 056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 284803 WARN (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 284804 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.c= .s.e.JettySolrRunner Start Jetty (original configured port=3D0) [junit4] 2> 284804 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.c= .s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 284804 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550= 056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 284805 WARN (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 284805 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.c= .s.e.JettySolrRunner Start Jetty (original configured port=3D0) [junit4] 2> 284805 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.c= .s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 284805 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550= 056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .session No SessionScavenger set, using defaults [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .session node0 Scavenging every 660000ms [junit4] 2> 284806 WARN (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .AbstractConnector Ignoring deprecated socket close linger time [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .h.ContextHandler Started o.e.j.s.ServletContextHandler@56854ed1{/solr,null= ,AVAILABLE} [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.c= .s.e.JettySolrRunner Start Jetty (original configured port=3D0) [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.c= .s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ... [junit4] 2> 284806 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550= 056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_201-b09 [junit4] 2> 284807 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 284807 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .session No SessionScavenger set, using defaults [junit4] 2> 284807 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .session node0 Scavenging every 600000ms [junit4] 2> 284807 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .h.ContextHandler Started o.e.j.s.ServletContextHandler@5909cc7b{/solr,null= ,AVAILABLE} [junit4] 2> 284808 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 284808 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .session No SessionScavenger set, using defaults [junit4] 2> 284808 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .session node0 Scavenging every 660000ms [junit4] 2> 284808 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .h.ContextHandler Started o.e.j.s.ServletContextHandler@1f80bea0{/solr,null= ,AVAILABLE} [junit4] 2> 284811 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .session DefaultSessionIdManager workerName=3Dnode0 [junit4] 2> 284811 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .session No SessionScavenger set, using defaults [junit4] 2> 284811 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .session node0 Scavenging every 600000ms [junit4] 2> 284811 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .h.ContextHandler Started o.e.j.s.ServletContextHandler@1deda13c{/solr,null= ,AVAILABLE} [junit4] 2> 284812 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .AbstractConnector Started ServerConnector@11b063da{HTTP/1.1,[http/1.1, h2c= ]}{127.0.0.1:34401} [junit4] 2> 284812 INFO (jetty-launcher-1676-thread-1) [ ] o.e.j.s= .Server Started @285136ms [junit4] 2> 284812 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.c= .s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D344= 01} [junit4] 2> 284812 ERROR (jetty-launcher-1676-thread-1) [ ] o.a.s.u= .StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missi= ng or incomplete. [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLogg= erFactory [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versi= on 8.2.0 [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-04T08:52:59.561Z [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .AbstractConnector Started ServerConnector@1c5ffe86{HTTP/1.1,[http/1.1, h2c= ]}{127.0.0.1:44636} [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.e.j.s= .Server Started @285137ms [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.c= .s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D446= 36} [junit4] 2> 284813 ERROR (jetty-launcher-1676-thread-2) [ ] o.a.s.u= .StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missi= ng or incomplete. [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLogg= erFactory [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versi= on 8.2.0 [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-04T08:52:59.561Z [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .AbstractConnector Started ServerConnector@74284e2b{HTTP/1.1,[http/1.1, h2c= ]}{127.0.0.1:42948} [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-4) [ ] o.e.j.s= .Server Started @285137ms [junit4] 2> 284813 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.c= .s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D429= 48} [junit4] 2> 284814 ERROR (jetty-launcher-1676-thread-4) [ ] o.a.s.u= .StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missi= ng or incomplete. [junit4] 2> 284814 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLogg= erFactory [junit4] 2> 284814 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versi= on 8.2.0 [junit4] 2> 284814 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 284814 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 284814 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-04T08:52:59.562Z [junit4] 2> 284816 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .AbstractConnector Started ServerConnector@398434cd{HTTP/1.1,[http/1.1, h2c= ]}{127.0.0.1:39820} [junit4] 2> 284816 INFO (jetty-launcher-1676-thread-3) [ ] o.e.j.s= .Server Started @285140ms [junit4] 2> 284816 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.c= .s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D398= 20} [junit4] 2> 284817 ERROR (jetty-launcher-1676-thread-3) [ ] o.a.s.u= .StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missi= ng or incomplete. [junit4] 2> 284817 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLogg= erFactory [junit4] 2> 284817 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter ___ _ Welcome to Apache Solr=E2=84=A2 versi= on 8.2.0 [junit4] 2> 284817 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null [junit4] 2> 284817 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null [junit4] 2> 284817 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter |___/\___/_|_| Start time: 2019-05-04T08:52:59.565Z [junit4] 2> 284817 INFO (zkConnectionManagerCallback-1680-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284818 INFO (zkConnectionManagerCallback-1678-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284818 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.s= .SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 284819 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.s= .SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 284819 INFO (zkConnectionManagerCallback-1682-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284820 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.s= .SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 284826 INFO (zkConnectionManagerCallback-1684-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 284828 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.s= .SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 285189 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.h= .c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker= [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3Dtrue] [junit4] 2> 285191 WARN (jetty-launcher-1676-thread-3) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@6da46560[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285193 WARN (jetty-launcher-1676-thread-3) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@74bf1383[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285194 INFO (jetty-launcher-1676-thread-3) [ ] o.a.s.c= .ZkContainer Zookeeper client=3D127.0.0.1:56159/solr [junit4] 2> 285196 INFO (zkConnectionManagerCallback-1694-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285218 INFO (zkConnectionManagerCallback-1696-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285288 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader = 127.0.0.1:39820_solr [junit4] 2> 285289 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.c.Overseer Overseer (id=3D72080253579689992-127.0.0.1:= 39820_solr-n_0000000000) starting [junit4] 2> 285295 INFO (zkConnectionManagerCallback-1703-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285298 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.= 1:56159/solr ready [junit4] 2> 285299 INFO (OverseerStateUpdate-72080253579689992-127.0.= 0.1:39820_solr-n_0000000000) [n:127.0.0.1:39820_solr ] o.a.s.c.Overseer = Starting to work on the main queue : 127.0.0.1:39820_solr [junit4] 2> 285299 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/liv= e_nodes/127.0.0.1:39820_solr [junit4] 2> 285302 INFO (OverseerStateUpdate-72080253579689992-127.0.= 0.1:39820_solr-n_0000000000) [n:127.0.0.1:39820_solr ] o.a.s.c.c.ZkState= Reader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 285303 INFO (zkCallback-1702-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 285320 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keepi= ng metrics history in memory. [junit4] 2> 285356 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39820.sol= r.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.J= mxMBeanServer@41e12a70 [junit4] 2> 285362 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39820.sol= r.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.Jmx= MBeanServer@41e12a70 [junit4] 2> 285362 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_39820.sol= r.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver= .JmxMBeanServer@41e12a70 [junit4] 2> 285363 INFO (jetty-launcher-1676-thread-3) [n:127.0.0.1:3= 9820_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions under= neath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/sol= r-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_5366837DEF97E64= E-001/tempDir-001/node4/. [junit4] 2> 285500 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.h= .c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker= [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3Dtrue] [junit4] 2> 285506 WARN (jetty-launcher-1676-thread-4) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@1a3dd279[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285509 WARN (jetty-launcher-1676-thread-4) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@2c4a326d[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285510 INFO (jetty-launcher-1676-thread-4) [ ] o.a.s.c= .ZkContainer Zookeeper client=3D127.0.0.1:56159/solr [junit4] 2> 285512 INFO (zkConnectionManagerCallback-1710-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285515 INFO (zkConnectionManagerCallback-1712-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285517 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.h= .c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker= [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3Dtrue] [junit4] 2> 285519 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (1) [junit4] 2> 285520 WARN (jetty-launcher-1676-thread-1) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@149f3892[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285523 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.ZkController Publish node=3D127.0.0.1:42948_solr as = DOWN [junit4] 2> 285524 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient c= ache for 2147483647 transient cores [junit4] 2> 285524 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/liv= e_nodes/127.0.0.1:42948_solr [junit4] 2> 285525 INFO (zkCallback-1695-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 285525 INFO (zkCallback-1702-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 285526 WARN (jetty-launcher-1676-thread-1) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@628f92dd[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 285526 INFO (jetty-launcher-1676-thread-1) [ ] o.a.s.c= .ZkContainer Zookeeper client=3D127.0.0.1:56159/solr [junit4] 2> 285528 INFO (zkCallback-1711-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 285538 INFO (zkConnectionManagerCallback-1720-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285541 INFO (zkConnectionManagerCallback-1722-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285546 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (2) [junit4] 2> 285549 INFO (zkConnectionManagerCallback-1729-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285550 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.ZkController Publish node=3D127.0.0.1:34401_solr as = DOWN [junit4] 2> 285551 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (2) [junit4] 2> 285552 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient c= ache for 2147483647 transient cores [junit4] 2> 285552 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/liv= e_nodes/127.0.0.1:34401_solr [junit4] 2> 285553 INFO (zkCallback-1695-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 285554 INFO (zkCallback-1702-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 285554 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.= 1:56159/solr ready [junit4] 2> 285554 INFO (zkCallback-1711-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 285555 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keepi= ng metrics history in memory. [junit4] 2> 285556 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 285558 INFO (zkCallback-1728-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 285574 INFO (zkConnectionManagerCallback-1735-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 285575 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (3) [junit4] 2> 285576 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.= 1:56159/solr ready [junit4] 2> 285577 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42948.sol= r.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.J= mxMBeanServer@41e12a70 [junit4] 2> 285577 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keepi= ng metrics history in memory. [junit4] 2> 285587 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42948.sol= r.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.Jmx= MBeanServer@41e12a70 [junit4] 2> 285587 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_42948.sol= r.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver= .JmxMBeanServer@41e12a70 [junit4] 2> 285588 INFO (jetty-launcher-1676-thread-4) [n:127.0.0.1:4= 2948_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions under= neath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/sol= r-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_5366837DEF97E64= E-001/tempDir-001/node3/. [junit4] 2> 285594 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34401.sol= r.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.J= mxMBeanServer@41e12a70 [junit4] 2> 285601 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34401.sol= r.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.Jmx= MBeanServer@41e12a70 [junit4] 2> 285601 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_34401.sol= r.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver= .JmxMBeanServer@41e12a70 [junit4] 2> 285601 INFO (jetty-launcher-1676-thread-1) [n:127.0.0.1:3= 4401_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions under= neath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/sol= r-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_5366837DEF97E64= E-001/tempDir-001/node1/. [junit4] 2> 286120 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.h= .c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker= [whitelistHosts=3Dnull, whitelistHostCheckingEnabled=3Dtrue] [junit4] 2> 286121 WARN (jetty-launcher-1676-thread-2) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@5ed11de1[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 286127 WARN (jetty-launcher-1676-thread-2) [ ] o.e.j.u= .s.S.config No Client EndPointIdentificationAlgorithm configured for SslCon= textFactory@5277384[provider=3Dnull,keyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 286128 INFO (jetty-launcher-1676-thread-2) [ ] o.a.s.c= .ZkContainer Zookeeper client=3D127.0.0.1:56159/solr [junit4] 2> 286131 INFO (zkConnectionManagerCallback-1742-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286134 INFO (zkConnectionManagerCallback-1744-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286141 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (3) [junit4] 2> 286147 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.ZkController Publish node=3D127.0.0.1:44636_solr as = DOWN [junit4] 2> 286149 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient c= ache for 2147483647 transient cores [junit4] 2> 286149 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/liv= e_nodes/127.0.0.1:44636_solr [junit4] 2> 286151 INFO (zkCallback-1702-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286151 INFO (zkCallback-1695-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286151 INFO (zkCallback-1711-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286151 INFO (zkCallback-1728-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286151 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286152 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286153 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286169 INFO (zkConnectionManagerCallback-1751-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286171 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper...= (0) -> (4) [junit4] 2> 286171 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.= 1:56159/solr ready [junit4] 2> 286171 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keepi= ng metrics history in memory. [junit4] 2> 286188 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44636.sol= r.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.J= mxMBeanServer@41e12a70 [junit4] 2> 286194 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44636.sol= r.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.Jmx= MBeanServer@41e12a70 [junit4] 2> 286194 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_44636.sol= r.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver= .JmxMBeanServer@41e12a70 [junit4] 2> 286195 INFO (jetty-launcher-1676-thread-2) [n:127.0.0.1:4= 4636_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions under= neath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris/solr/build/sol= r-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_5366837DEF97E64= E-001/tempDir-001/node2/. [junit4] 2> 286232 INFO (zkConnectionManagerCallback-1757-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286235 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (4) [junit4] 2> 286237 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Clus= ter at 127.0.0.1:56159/solr ready [junit4] 2> 286241 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreConta= iner instance=3D688735817 [junit4] 2> 286241 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Remove node as live in Z= ooKeeper:/live_nodes/127.0.0.1:39820_solr [junit4] 2> 286241 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish this node as DOW= N... [junit4] 2> 286242 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :39820_solr as DOWN [junit4] 2> 286245 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocat= ing transient cache for 2147483647 transient cores [junit4] 2> 286245 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 286245 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@3fcab402: rootName =3D sol= r_39820, domain =3D solr.node, service url =3D null, agent id =3D null] for= registry solr.node / com.codahale.metrics.MetricRegistry@555a9069 [junit4] 2> 286249 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 286249 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@35414e88: rootName =3D sol= r_39820, domain =3D solr.jvm, service url =3D null, agent id =3D null] for = registry solr.jvm / com.codahale.metrics.MetricRegistry@3de79e5f [junit4] 2> 286251 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 286251 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@5bd189bd: rootName =3D sol= r_39820, domain =3D solr.jetty, service url =3D null, agent id =3D null] fo= r registry solr.jetty / com.codahale.metrics.MetricRegistry@7a931965 [junit4] 2> 286252 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.cluster, tag=3Dnull [junit4] 2> 286252 INFO (closeThreadPool-1761-thread-2) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689992-127.0.0.1:39820_solr-n_00000000= 00) closing [junit4] 2> 286252 INFO (OverseerAutoScalingTriggerThread-72080253579= 689992-127.0.0.1:39820_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerT= hread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 286252 INFO (OverseerStateUpdate-72080253579689992-127.0.= 0.1:39820_solr-n_0000000000) [n:127.0.0.1:39820_solr ] o.a.s.c.Overseer = Overseer Loop exiting : 127.0.0.1:39820_solr [junit4] 2> 286260 INFO (zkCallback-1702-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286261 INFO (zkCallback-1711-thread-1) [ ] o.a.s.c.Ove= rseerElectionContext I am going to be the leader 127.0.0.1:42948_solr [junit4] 2> 286261 INFO (zkCallback-1711-thread-2) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286261 INFO (zkCallback-1728-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286261 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286261 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286263 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.Overseer Overseer (id=3D7208025357968= 9992-127.0.0.1:39820_solr-n_0000000000) closing [junit4] 2> 286264 INFO (closeThreadPool-1761-thread-1) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689992-127.0.0.1:39820_solr-n_00000000= 00) closing [junit4] 2> 286265 INFO (zkCallback-1711-thread-1) [n:127.0.0.1:42948= _solr ] o.a.s.c.Overseer Overseer (id=3D72080253579689995-127.0.0.1:4294= 8_solr-n_0000000001) starting [junit4] 2> 286265 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286265 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286265 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 286269 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConne= ctor@398434cd{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 286270 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.Serv= letContextHandler@5909cc7b{/solr,null,UNAVAILABLE} [junit4] 2> 286270 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 286272 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (orig= inal configured port=3D0) [junit4] 2> 286272 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Ignoring deprecated= socket close linger time [junit4] 2> 286273 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start J= etty on port 0 try number 1 ... [junit4] 2> 286273 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built:= 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; j= vm 1.8.0_201-b09 [junit4] 2> 286274 INFO (OverseerStateUpdate-72080253579689995-127.0.= 0.1:42948_solr-n_0000000001) [n:127.0.0.1:42948_solr ] o.a.s.c.Overseer = Starting to work on the main queue : 127.0.0.1:42948_solr [junit4] 2> 286276 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session DefaultSessionIdManager worke= rName=3Dnode0 [junit4] 2> 286276 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session No SessionScavenger set, usin= g defaults [junit4] 2> 286276 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000= ms [junit4] 2> 286276 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.Serv= letContextHandler@8e6cd99{/solr,null,AVAILABLE} [junit4] 2> 286277 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConne= ctor@6bdcb6d7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41707} [junit4] 2> 286277 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server Started @286601ms [junit4] 2> 286277 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:= {hostContext=3D/solr, hostPort=3D34295} [junit4] 2> 286277 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Opti= on solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 286277 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger facto= ry org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 286278 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ = Welcome to Apache Solr=E2=84=A2 version 8.2.0 [junit4] 2> 286278 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ = Starting in cloud mode on port null [junit4] 2> 286278 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| = Install dir: null [junit4] 2> 286278 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| = Start time: 2019-05-04T08:53:01.026Z [junit4] 2> 286283 INFO (zkConnectionManagerCallback-1763-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286284 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in = ZooKeeper. Loading... [junit4] 2> 286924 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitel= ist initialized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHost= CheckingEnabled=3Dtrue] [junit4] 2> 286926 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@50addaa0[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 286929 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@65728f54[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 286930 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=3D127.0.= 0.1:56159/solr [junit4] 2> 286932 INFO (zkConnectionManagerCallback-1770-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286935 INFO (zkConnectionManagerCallback-1772-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286947 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.c.ZkStateReader= Updated live nodes from ZooKeeper... (0) -> (3) [junit4] 2> 286952 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.ZkController Pu= blish node=3D127.0.0.1:34295_solr as DOWN [junit4] 2> 286953 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.TransientSolrCo= reCacheDefault Allocating transient cache for 2147483647 transient cores [junit4] 2> 286953 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.ZkController Re= gister node as live in ZooKeeper:/live_nodes/127.0.0.1:34295_solr [junit4] 2> 286955 INFO (zkCallback-1728-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286955 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286955 INFO (zkCallback-1711-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286956 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286956 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286956 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286956 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286958 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 286976 INFO (zkConnectionManagerCallback-1779-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 286979 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.c.ZkStateReader= Updated live nodes from ZooKeeper... (0) -> (4) [junit4] 2> 286981 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.s.i.ZkClientClu= sterStateProvider Cluster at 127.0.0.1:56159/solr ready [junit4] 2> 286981 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.h.a.MetricsHistor= yHandler No .system collection, keeping metrics history in memory. [junit4] 2> 286995 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.m.r.SolrJmxReport= er JMX monitoring for 'solr_34295.solr.node' (registry 'solr.node') enabled= at server: com.sun.jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287007 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.m.r.SolrJmxReport= er JMX monitoring for 'solr_34295.solr.jvm' (registry 'solr.jvm') enabled a= t server: com.sun.jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287008 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.m.r.SolrJmxReport= er JMX monitoring for 'solr_34295.solr.jetty' (registry 'solr.jetty') enabl= ed at server: com.sun.jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [n:127.0.0.1:34295_solr ] o.a.s.c.CorePropertiesL= ocator Found 0 core definitions underneath /export/home/jenkins/workspace/L= ucene-Solr-8.x-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.TestPul= lReplicaErrorHandling_5366837DEF97E64E-001/tempDir-001/node4/. [junit4] 2> 287048 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding p= roxy for URL: http://127.0.0.1:41707/solr. Proxy: http://127.0.0.1:34295/so= lr [junit4] 2> 287049 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreConta= iner instance=3D1320602802 [junit4] 2> 287049 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Remove node as live in Z= ooKeeper:/live_nodes/127.0.0.1:42948_solr [junit4] 2> 287050 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish this node as DOW= N... [junit4] 2> 287050 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :42948_solr as DOWN [junit4] 2> 287054 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 287054 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@7b88b438: rootName =3D sol= r_42948, domain =3D solr.node, service url =3D null, agent id =3D null] for= registry solr.node / com.codahale.metrics.MetricRegistry@1277141e [junit4] 2> 287062 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 287062 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@1997dd85: rootName =3D sol= r_42948, domain =3D solr.jvm, service url =3D null, agent id =3D null] for = registry solr.jvm / com.codahale.metrics.MetricRegistry@3de79e5f [junit4] 2> 287064 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 287064 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@64c78153: rootName =3D sol= r_42948, domain =3D solr.jetty, service url =3D null, agent id =3D null] fo= r registry solr.jetty / com.codahale.metrics.MetricRegistry@7a931965 [junit4] 2> 287064 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.cluster, tag=3Dnull [junit4] 2> 287065 INFO (closeThreadPool-1784-thread-1) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689995-127.0.0.1:42948_solr-n_00000000= 01) closing [junit4] 2> 287065 INFO (OverseerStateUpdate-72080253579689995-127.0.= 0.1:42948_solr-n_0000000001) [n:127.0.0.1:42948_solr ] o.a.s.c.Overseer = Overseer Loop exiting : 127.0.0.1:42948_solr [junit4] 2> 287065 INFO (OverseerAutoScalingTriggerThread-72080253579= 689995-127.0.0.1:42948_solr-n_0000000001) [ ] o.a.s.c.a.OverseerTriggerT= hread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 287070 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287070 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.Ove= rseerElectionContext I am going to be the leader 127.0.0.1:34401_solr [junit4] 2> 287070 INFO (zkCallback-1728-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287070 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287070 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287071 INFO (zkCallback-1721-thread-2) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287071 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287072 INFO (zkCallback-1721-thread-1) [n:127.0.0.1:34401= _solr ] o.a.s.c.Overseer Overseer (id=3D72080253579689997-127.0.0.1:3440= 1_solr-n_0000000002) starting [junit4] 2> 287077 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.Overseer Overseer (id=3D7208025357968= 9995-127.0.0.1:42948_solr-n_0000000001) closing [junit4] 2> 287077 INFO (closeThreadPool-1784-thread-2) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689995-127.0.0.1:42948_solr-n_00000000= 01) closing [junit4] 2> 287078 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287079 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287083 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConne= ctor@74284e2b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 287084 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.Serv= letContextHandler@1deda13c{/solr,null,UNAVAILABLE} [junit4] 2> 287085 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 287086 INFO (OverseerStateUpdate-72080253579689997-127.0.= 0.1:34401_solr-n_0000000002) [n:127.0.0.1:34401_solr ] o.a.s.c.Overseer = Starting to work on the main queue : 127.0.0.1:34401_solr [junit4] 2> 287087 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (orig= inal configured port=3D0) [junit4] 2> 287087 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Ignoring deprecated= socket close linger time [junit4] 2> 287087 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start J= etty on port 0 try number 1 ... [junit4] 2> 287088 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built:= 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; j= vm 1.8.0_201-b09 [junit4] 2> 287088 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session DefaultSessionIdManager worke= rName=3Dnode0 [junit4] 2> 287088 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session No SessionScavenger set, usin= g defaults [junit4] 2> 287088 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000= ms [junit4] 2> 287088 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.Serv= letContextHandler@78b16ba9{/solr,null,AVAILABLE} [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConne= ctor@35d013b7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:63521} [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server Started @287413ms [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:= {hostContext=3D/solr, hostPort=3D55454} [junit4] 2> 287089 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Opti= on solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger facto= ry org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ = Welcome to Apache Solr=E2=84=A2 version 8.2.0 [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ = Starting in cloud mode on port null [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| = Install dir: null [junit4] 2> 287089 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| = Start time: 2019-05-04T08:53:01.837Z [junit4] 2> 287093 INFO (zkConnectionManagerCallback-1786-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 287095 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in = ZooKeeper. Loading... [junit4] 2> 287839 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitel= ist initialized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHost= CheckingEnabled=3Dtrue] [junit4] 2> 287840 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@3ed6222b[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 287843 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@3595f7ff[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 287843 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=3D127.0.= 0.1:56159/solr [junit4] 2> 287846 INFO (zkConnectionManagerCallback-1793-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 287849 INFO (zkConnectionManagerCallback-1795-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 287857 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (3) [junit4] 2> 287863 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :55454_solr as DOWN [junit4] 2> 287865 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocat= ing transient cache for 2147483647 transient cores [junit4] 2> 287865 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Register node as live in= ZooKeeper:/live_nodes/127.0.0.1:55454_solr [junit4] 2> 287867 INFO (zkCallback-1721-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287868 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287868 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287869 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287869 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287869 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287870 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287872 INFO (zkCallback-1794-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 287893 INFO (zkConnectionManagerCallback-1802-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 287895 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (4) [junit4] 2> 287898 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Clus= ter at 127.0.0.1:56159/solr ready [junit4] 2> 287898 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system co= llection, keeping metrics history in memory. [junit4] 2> 287926 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55454.solr.node' (registry 'solr.node') enabled at server: com.sun.jm= x.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287933 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55454.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.= mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287933 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55454.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.= jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 287934 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 0 core de= finitions underneath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris= /solr/build/solr-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_= 5366837DEF97E64E-001/tempDir-001/node3/. [junit4] 2> 287972 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding p= roxy for URL: http://127.0.0.1:63521/solr. Proxy: http://127.0.0.1:55454/so= lr [junit4] 2> 287972 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreConta= iner instance=3D2074324045 [junit4] 2> 287972 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Remove node as live in Z= ooKeeper:/live_nodes/127.0.0.1:34401_solr [junit4] 2> 287973 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish this node as DOW= N... [junit4] 2> 287973 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :34401_solr as DOWN [junit4] 2> 287977 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 287977 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@7d725fe9: rootName =3D sol= r_34401, domain =3D solr.node, service url =3D null, agent id =3D null] for= registry solr.node / com.codahale.metrics.MetricRegistry@797ab134 [junit4] 2> 287981 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 287981 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@3f67804a: rootName =3D sol= r_34401, domain =3D solr.jvm, service url =3D null, agent id =3D null] for = registry solr.jvm / com.codahale.metrics.MetricRegistry@3de79e5f [junit4] 2> 287983 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 287983 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@67e240da: rootName =3D sol= r_34401, domain =3D solr.jetty, service url =3D null, agent id =3D null] fo= r registry solr.jetty / com.codahale.metrics.MetricRegistry@7a931965 [junit4] 2> 287983 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.cluster, tag=3Dnull [junit4] 2> 287985 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287986 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.Overseer Overseer (id=3D7208025357968= 9997-127.0.0.1:34401_solr-n_0000000002) closing [junit4] 2> 287986 INFO (zkCallback-1743-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287986 INFO (OverseerStateUpdate-72080253579689997-127.0.= 0.1:34401_solr-n_0000000002) [n:127.0.0.1:34401_solr ] o.a.s.c.Overseer = Overseer Loop exiting : 127.0.0.1:34401_solr [junit4] 2> 287986 INFO (OverseerAutoScalingTriggerThread-72080253579= 689997-127.0.0.1:34401_solr-n_0000000002) [ ] o.a.s.c.a.OverseerTriggerT= hread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 287989 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287989 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287990 INFO (zkCallback-1734-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287990 INFO (zkCallback-1801-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287990 INFO (zkCallback-1743-thread-2) [ ] o.a.s.c.Ove= rseerElectionContext I am going to be the leader 127.0.0.1:44636_solr [junit4] 2> 287991 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287991 INFO (zkCallback-1743-thread-2) [n:127.0.0.1:44636= _solr ] o.a.s.c.Overseer Overseer (id=3D72080253579690001-127.0.0.1:4463= 6_solr-n_0000000003) starting [junit4] 2> 287992 INFO (zkCallback-1794-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 287995 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ = ] o.a.z.s.NIOServerCnxn Unable to read additional data from client session= id 0x100149bd5f0000f, likely client has closed socket [junit4] 2> 287997 INFO (closeThreadPool-1807-thread-1) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689997-127.0.0.1:34401_solr-n_00000000= 02) closing [junit4] 2> 287998 INFO (closeThreadPool-1807-thread-2) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579689997-127.0.0.1:34401_solr-n_00000000= 02) closing [junit4] 2> 287999 INFO (OverseerStateUpdate-72080253579690001-127.0.= 0.1:44636_solr-n_0000000003) [n:127.0.0.1:44636_solr ] o.a.s.c.Overseer = Starting to work on the main queue : 127.0.0.1:44636_solr [junit4] 2> 288003 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConne= ctor@11b063da{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 288004 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.Serv= letContextHandler@56854ed1{/solr,null,UNAVAILABLE} [junit4] 2> 288004 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 288008 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (orig= inal configured port=3D0) [junit4] 2> 288008 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Ignoring deprecated= socket close linger time [junit4] 2> 288009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start J= etty on port 0 try number 1 ... [junit4] 2> 288009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built:= 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; j= vm 1.8.0_201-b09 [junit4] 2> 288009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session DefaultSessionIdManager worke= rName=3Dnode0 [junit4] 2> 288009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session No SessionScavenger set, usin= g defaults [junit4] 2> 288009 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Scavenging every 600000= ms [junit4] 2> 288010 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.Serv= letContextHandler@b971643{/solr,null,AVAILABLE} [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConne= ctor@d1cf2c7{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:63018} [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server Started @288335ms [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:= {hostContext=3D/solr, hostPort=3D55958} [junit4] 2> 288011 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Opti= on solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger facto= ry org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ = Welcome to Apache Solr=E2=84=A2 version 8.2.0 [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ = Starting in cloud mode on port null [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| = Install dir: null [junit4] 2> 288011 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| = Start time: 2019-05-04T08:53:02.759Z [junit4] 2> 288014 INFO (zkConnectionManagerCallback-1809-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 288014 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in = ZooKeeper. Loading... [junit4] 2> 288594 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitel= ist initialized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHost= CheckingEnabled=3Dtrue] [junit4] 2> 288595 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@fd9559f[provider=3Dnull,ke= yStore=3Dnull,trustStore=3Dnull] [junit4] 2> 288599 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@450988ed[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 288599 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=3D127.0.= 0.1:56159/solr [junit4] 2> 288601 INFO (zkConnectionManagerCallback-1816-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 288604 INFO (zkConnectionManagerCallback-1818-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 288614 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (3) [junit4] 2> 288620 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :55958_solr as DOWN [junit4] 2> 288621 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocat= ing transient cache for 2147483647 transient cores [junit4] 2> 288621 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Register node as live in= ZooKeeper:/live_nodes/127.0.0.1:55958_solr [junit4] 2> 288623 INFO (zkCallback-1743-thread-2) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288623 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288623 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288623 INFO (zkCallback-1750-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288623 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288623 INFO (zkCallback-1794-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288624 INFO (zkCallback-1801-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288625 INFO (zkCallback-1817-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 288648 INFO (zkConnectionManagerCallback-1825-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 288651 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (4) [junit4] 2> 288653 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Clus= ter at 127.0.0.1:56159/solr ready [junit4] 2> 288653 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system co= llection, keeping metrics history in memory. [junit4] 2> 288666 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55958.solr.node' (registry 'solr.node') enabled at server: com.sun.jm= x.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 288674 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55958.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.= mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 288674 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_55958.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.= jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 288675 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 0 core de= finitions underneath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris= /solr/build/solr-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_= 5366837DEF97E64E-001/tempDir-001/node1/. [junit4] 2> 288717 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding p= roxy for URL: http://127.0.0.1:63018/solr. Proxy: http://127.0.0.1:55958/so= lr [junit4] 2> 288717 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CoreContainer Shutting down CoreConta= iner instance=3D1697665822 [junit4] 2> 288717 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Remove node as live in Z= ooKeeper:/live_nodes/127.0.0.1:44636_solr [junit4] 2> 288718 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish this node as DOW= N... [junit4] 2> 288718 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :44636_solr as DOWN [junit4] 2> 288722 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.node, tag=3Dnull [junit4] 2> 288723 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@6f377e25: rootName =3D sol= r_44636, domain =3D solr.node, service url =3D null, agent id =3D null] for= registry solr.node / com.codahale.metrics.MetricRegistry@27b3d693 [junit4] 2> 288726 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jvm, tag=3Dnull [junit4] 2> 288726 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@3615555e: rootName =3D sol= r_44636, domain =3D solr.jvm, service url =3D null, agent id =3D null] for = registry solr.jvm / com.codahale.metrics.MetricRegistry@3de79e5f [junit4] 2> 288728 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.jetty, tag=3Dnull [junit4] 2> 288728 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [o= rg.apache.solr.metrics.reporters.SolrJmxReporter@532a2dbb: rootName =3D sol= r_44636, domain =3D solr.jetty, service url =3D null, agent id =3D null] fo= r registry solr.jetty / com.codahale.metrics.MetricRegistry@7a931965 [junit4] 2> 288728 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.SolrMetricManager Closing metric repo= rters for registry=3Dsolr.cluster, tag=3Dnull [junit4] 2> 288728 INFO (closeThreadPool-1830-thread-2) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579690001-127.0.0.1:44636_solr-n_00000000= 03) closing [junit4] 2> 288734 INFO (OverseerStateUpdate-72080253579690001-127.0.= 0.1:44636_solr-n_0000000003) [n:127.0.0.1:44636_solr ] o.a.s.c.Overseer = Overseer Loop exiting : 127.0.0.1:44636_solr [junit4] 2> 288734 INFO (OverseerAutoScalingTriggerThread-72080253579= 690001-127.0.0.1:44636_solr-n_0000000003) [ ] o.a.s.c.a.OverseerTriggerT= hread OverseerTriggerThread woken up but we are closed, exiting. [junit4] 2> 288738 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288738 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288739 INFO (zkCallback-1801-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288739 INFO (zkCallback-1771-thread-2) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288739 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.Ove= rseerElectionContext I am going to be the leader 127.0.0.1:34295_solr [junit4] 2> 288741 INFO (zkCallback-1771-thread-1) [n:127.0.0.1:34295= _solr ] o.a.s.c.Overseer Overseer (id=3D72080253579690006-127.0.0.1:3429= 5_solr-n_0000000004) starting [junit4] 2> 288741 INFO (zkCallback-1794-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288742 INFO (zkCallback-1824-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288742 INFO (zkCallback-1817-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (4) -> (3) [junit4] 2> 288743 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.Overseer Overseer (id=3D7208025357969= 0001-127.0.0.1:44636_solr-n_0000000003) closing [junit4] 2> 288743 INFO (closeThreadPool-1830-thread-1) [ ] o.a.s.= c.Overseer Overseer (id=3D72080253579690001-127.0.0.1:44636_solr-n_00000000= 03) closing [junit4] 2> 288747 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Stopped ServerConne= ctor@1c5ffe86{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0} [junit4] 2> 288747 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.Serv= letContextHandler@1f80bea0{/solr,null,UNAVAILABLE} [junit4] 2> 288747 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 288749 INFO (OverseerStateUpdate-72080253579690006-127.0.= 0.1:34295_solr-n_0000000004) [n:127.0.0.1:34295_solr ] o.a.s.c.Overseer = Starting to work on the main queue : 127.0.0.1:34295_solr [junit4] 2> 288752 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (orig= inal configured port=3D0) [junit4] 2> 288752 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Ignoring deprecated= socket close linger time [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start J= etty on port 0 try number 1 ... [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built:= 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; j= vm 1.8.0_201-b09 [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session DefaultSessionIdManager worke= rName=3Dnode0 [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session No SessionScavenger set, usin= g defaults [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.session node0 Scavenging every 660000= ms [junit4] 2> 288754 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.Serv= letContextHandler@27dc8799{/solr,null,AVAILABLE} [junit4] 2> 288756 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.AbstractConnector Started ServerConne= ctor@45c27fb1{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:39052} [junit4] 2> 288756 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.s.Server Started @289081ms [junit4] 2> 288756 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:= {hostContext=3D/solr, hostPort=3D37336} [junit4] 2> 288756 ERROR (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.u.StartupLoggingUtils Missing Java Opti= on solr.log.dir. Logging may be missing or incomplete. [junit4] 2> 288756 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter Using logger facto= ry org.apache.logging.slf4j.Log4jLoggerFactory [junit4] 2> 288757 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter ___ _ = Welcome to Apache Solr=E2=84=A2 version 8.2.0 [junit4] 2> 288757 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ = Starting in cloud mode on port null [junit4] 2> 288757 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| = Install dir: null [junit4] 2> 288757 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| = Start time: 2019-05-04T08:53:03.505Z [junit4] 2> 288759 INFO (zkConnectionManagerCallback-1832-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 288760 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in = ZooKeeper. Loading... [junit4] 2> 289111 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitel= ist initialized: WhitelistHostChecker [whitelistHosts=3Dnull, whitelistHost= CheckingEnabled=3Dtrue] [junit4] 2> 289112 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@48ab49a[provider=3Dnull,ke= yStore=3Dnull,trustStore=3Dnull] [junit4] 2> 289115 WARN (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.e.j.u.s.S.config No Client EndPointIdentifi= cationAlgorithm configured for SslContextFactory@408273b6[provider=3Dnull,k= eyStore=3Dnull,trustStore=3Dnull] [junit4] 2> 289116 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkContainer Zookeeper client=3D127.0.= 0.1:56159/solr [junit4] 2> 289118 INFO (zkConnectionManagerCallback-1839-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 289121 INFO (zkConnectionManagerCallback-1841-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 289128 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (3) [junit4] 2> 289133 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Publish node=3D127.0.0.1= :37336_solr as DOWN [junit4] 2> 289135 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocat= ing transient cache for 2147483647 transient cores [junit4] 2> 289135 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.ZkController Register node as live in= ZooKeeper:/live_nodes/127.0.0.1:37336_solr [junit4] 2> 289136 INFO (zkCallback-1778-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289136 INFO (zkCallback-1771-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289136 INFO (zkCallback-1756-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289137 INFO (zkCallback-1794-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289137 INFO (zkCallback-1801-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289137 INFO (zkCallback-1824-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289137 INFO (zkCallback-1817-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289142 INFO (zkCallback-1840-thread-1) [ ] o.a.s.c.c.Z= kStateReader Updated live nodes from ZooKeeper... (3) -> (4) [junit4] 2> 289160 INFO (zkConnectionManagerCallback-1848-thread-1) [= ] o.a.s.c.c.ConnectionManager zkClient has connected [junit4] 2> 289162 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes fr= om ZooKeeper... (0) -> (4) [junit4] 2> 289164 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Clus= ter at 127.0.0.1:56159/solr ready [junit4] 2> 289164 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.h.a.MetricsHistoryHandler No .system co= llection, keeping metrics history in memory. [junit4] 2> 289178 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_37336.solr.node' (registry 'solr.node') enabled at server: com.sun.jm= x.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 289185 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_37336.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.= mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 289185 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for = 'solr_37336.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.= jmx.mbeanserver.JmxMBeanServer@41e12a70 [junit4] 2> 289186 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.CorePropertiesLocator Found 0 core de= finitions underneath /export/home/jenkins/workspace/Lucene-Solr-8.x-Solaris= /solr/build/solr-core/test/J1/temp/solr.cloud.TestPullReplicaErrorHandling_= 5366837DEF97E64E-001/tempDir-001/node2/. [junit4] 2> 289224 INFO (SUITE-TestPullReplicaErrorHandling-seed#[536= 6837DEF97E64E]-worker) [ ] o.a.s.c.TestPullReplicaErrorHandling Adding p= roxy for URL: http://127.0.0.1:39052/solr. Proxy: http://127.0.0.1:37336/so= lr [junit4] 2> 289226 INFO (SocketProxy-Acceptor-34295) [ ] o.a.s.c.s= .c.SocketProxy accepted Socket[addr=3D/127.0.0.1,port=3D46759,localport=3D3= 4295], receiveBufferSize:130880 [junit4] 2> 289227 INFO (SocketProxy-Acceptor-34295) [ ] o.a.s.c.s= .c.SocketProxy proxy connection Socket[addr=3D/127.0.0.1,port=3D41707,local= port=3D46393], receiveBufferSize=3D139264 [junit4] 2> 289228 INFO (qtp1477574049-5133) [n:127.0.0.1:34295_solr = ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :clusterprop wi= th params val=3Dfalse&name=3DlegacyCloud&action=3DCLUSTERPROP&wt=3Djavabin&= version=3D2 and sendToOCPQueue=3Dtrue [junit4] 2> 289229 INFO (qtp1477574049-5133) [n:127.0.0.1:34295_solr = ] o.a.s.s.HttpSolrCall [admin] webapp=3Dnull path=3D/admin/collections p= arams=3D{val=3Dfalse&name=3DlegacyCloud&action=3DCLUSTERPROP&wt=3Djavabin&v= ersion=3D2} status=3D0 QTime=3D1 [junit4] 2> 289285 INFO (TEST-TestPullReplicaErrorHandling.testCantCo= nnectToPullReplica-seed#[5366837DEF97E64E]) [ ] o.a.s.SolrTestCaseJ4 ###= Starting testCantConnectToPullReplica [junit4] 2> 289287 INFO (qtp1477574049-5130) [n:127.0.0.1:34295_solr = ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with pa= rams pullReplicas=3D1&collection.configName=3Dconf&maxShardsPerNode=3D1&nam= e=3Dpull_replica_error_handling_test_cant_connect_to_pull_replica&nrtReplic= as=3D1&action=3DCREATE&numShards=3D2&tlogReplicas=3D0&wt=3Djavabin&version= =3D2 and sendToOCPQueue=3Dtrue [junit4] 2> 289290 INFO (OverseerThreadFactory-1536-thread-1-processi= ng-n:127.0.0.1:34295_solr) [n:127.0.0.1:34295_solr ] o.a.s.c.a.c.CreateC= ollectionCmd Create collection pull_replica_error_handling_test_cant_connec= t_to_pull_replica [junit4] 2> 289402 INFO (OverseerStateUpdate-72080253579690006-127.0.= 0.1:34295_solr-n_0000000004) [n:127.0.0.1:34295_solr ] o.a.s.c.o.SliceMu= tator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_error_handling_test_cant_conn= ect_to_pull_replica", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_error_handling_test_cant_connect_to= _pull_replica_shard1_replica_n1", [junit4] 2> "state":"down", [junit4] 2> "base_url":"http://127.0.0.1:34295/solr", [junit4] 2> "type":"NRT", [junit4] 2> "waitForFinalState":"false"}=20 [junit4] 2> 289406 INFO (OverseerStateUpdate-72080253579690006-127.0.= 0.1:34295_solr-n_0000000004) [n:127.0.0.1:34295_solr ] o.a.s.c.o.SliceMu= tator createReplica() { [junit4] 2> "operation":"ADDREPLICA", [junit4] 2> "collection":"pull_replica_error_handling_test_cant_conn= ect_to_pull_replica", [junit4] 2> "shard":"shard1", [junit4] 2> "core":"pull_replica_error_handling_test_cant_connect_to= _pull_replica_s [...truncated too long message...] 7DEF97E64E]) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContext= Handler@2f739d52{/solr,null,UNAVAILABLE} [junit4] 2> 59556 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.e.j.s.session node0 Stopped scavenging [junit4] 2> 59560 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.a.s.c.OverseerRolesTest Expecting node: 127.0.= 0.1:53387_solr [junit4] 2> 59560 INFO (zkCallback-497-thread-1) [ ] o.a.s.c.c.ZkS= tateReader Updated live nodes from ZooKeeper... (6) -> (5) [junit4] 2> 59561 INFO (zkCallback-449-thread-2) [n:127.0.0.1:53387_s= olr ] o.a.s.c.Overseer Overseer (id=3D72080559043248144-127.0.0.1:53387_= solr-n_0000000002) starting [junit4] 2> 59566 INFO (OverseerStateUpdate-72080559043248144-127.0.0= .1:53387_solr-n_0000000002) [n:127.0.0.1:53387_solr ] o.a.s.c.Overseer S= tarting to work on the main queue : 127.0.0.1:53387_solr [junit4] 2> 59662 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.a.s.c.OverseerRolesTest ### Adding last overse= er designate 127.0.0.1:35915_solr [junit4] 2> 59688 INFO (qtp810307308-1198) [n:127.0.0.1:35915_solr = ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addrole with par= ams node=3D127.0.0.1:35915_solr&role=3Doverseer&action=3DADDROLE&wt=3Djavab= in&version=3D2 and sendToOCPQueue=3Dtrue [junit4] 2> 59696 INFO (OverseerThreadFactory-346-thread-1-processing= -n:127.0.0.1:53387_solr) [n:127.0.0.1:53387_solr ] o.a.s.c.a.c.OverseerR= oleCmd Overseer role added to 127.0.0.1:35915_solr [junit4] 2> 59700 INFO (qtp810307308-1198) [n:127.0.0.1:35915_solr = ] o.a.s.s.HttpSolrCall [admin] webapp=3Dnull path=3D/admin/collections par= ams=3D{node=3D127.0.0.1:35915_solr&role=3Doverseer&action=3DADDROLE&wt=3Dja= vabin&version=3D2} status=3D0 QTime=3D11 [junit4] 2> 59701 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.a.s.c.OverseerRolesTest Overseer: 127.0.0.1:53= 387_solr [junit4] 2> 59702 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.a.s.c.OverseerRolesTest Election queue:=20 [junit4] 2> 59703 INFO (qtp810307308-1196) [n:127.0.0.1:35915_solr = ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :removerole with = params node=3D127.0.0.1:53387_solr&role=3Doverseer&action=3DREMOVEROLE&wt= =3Djavabin&version=3D2 and sendToOCPQueue=3Dtrue [junit4] 2> 59706 INFO (OverseerCollectionConfigSetProcessor-72080559= 043248144-127.0.0.1:53387_solr-n_0000000002) [n:127.0.0.1:53387_solr ] o= .a.s.c.OverseerTaskQueue Response ZK path: /overseer/collection-queue-work/= qnr-0000000016 doesn't exist. Requestor may have disconnected from ZooKeep= er [junit4] 2> 59706 INFO (OverseerThreadFactory-346-thread-2-processing= -n:127.0.0.1:53387_solr) [n:127.0.0.1:53387_solr ] o.a.s.c.a.c.OverseerR= oleCmd Overseer role removed from 127.0.0.1:53387_solr [junit4] 2> 59707 INFO (Thread-247) [ ] o.a.s.c.OverseerNodePriori= tizer prioritizing overseer nodes at 72080559043248144-127.0.0.1:53387_solr= -n_0000000002 overseer designates are [127.0.0.1:42107_solr, 127.0.0.1:3591= 5_solr] [junit4] 2> 59708 INFO (Thread-247) [ ] o.a.s.c.OverseerNodePriori= tizer sorted nodes [72080559043248144-127.0.0.1:53387_solr-n_0000000002, 72= 080559043248146-127.0.0.1:64093_solr-n_0000000003, 72080559043248150-127.0.= 0.1:35915_solr-n_0000000004, 72080559043248153-127.0.0.1:53698_solr-n_00000= 00005, 72080559043248138-127.0.0.1:62258_solr-n_0000000006] [junit4] 2> 59708 INFO (Thread-247) [ ] o.a.s.c.OverseerNodePriori= tizer asking node 72080559043248150-127.0.0.1:35915_solr-n_0000000004 to co= me join election at head [junit4] 2> 59710 INFO (qtp810307308-1196) [n:127.0.0.1:35915_solr = ] o.a.s.s.HttpSolrCall [admin] webapp=3Dnull path=3D/admin/collections par= ams=3D{node=3D127.0.0.1:53387_solr&role=3Doverseer&action=3DREMOVEROLE&wt= =3Djavabin&version=3D2} status=3D0 QTime=3D6 [junit4] 2> 59710 INFO (TEST-OverseerRolesTest.testOverseerRole-seed#= [5366837DEF97E64E]) [ ] o.a.s.c.OverseerRolesTest Expecting node: 127.0.= 0.1:35915_solr [junit4] 2> 59719 INFO (qtp810307308-1197) [n:127.0.0.1:35915_solr = ] o.a.s.s.HttpSolrCall [admin] webapp=3Dnull path=3D/admin/cores params=3D= {op=3DrejoinAtHead&qt=3D/admin/cores&action=3DOVERSEEROP&electionNode=3D720= 80559043248150-127.0.0.1:35915_solr-n_0000000004&wt=3Djavabin&version=3D2} = status=3D0 QTime=3D2 [junit4] 2> 59720 INFO (Thread-247) [ ] o.a.s.c.OverseerNodePriori= tizer asking the old first in line 72080559043248146-127.0.0.1:64093_solr-n= _0000000003 to rejoin election =20 [junit4] 2> 59741 INFO (qtp883181072-1170) [n:127.0.0.1:64093_solr = ] o.a.s.s.HttpSolrCall [admin] webapp=3Dnull path=3D/admin/cores params=3D= {op=3Drejoin&qt=3D/admin/cores&action=3DOVERSEEROP&electionNode=3D720805590= 43248146-127.0.0.1:64093_solr-n_0000000003&wt=3Djavabin&version=3D2} status= =3D0 QTime=3D3 [junit4] 2> 59745 INFO (OverseerStateUpdate-72080559043248144-127.0.0= .1:53387_solr-n_0000000002) [n:127.0.0.1:53387_solr ] o.a.s.c.Overseer Q= uit command received { [junit4] 2> "operation":"quit", [junit4] 2> "id":"72080559043248144-127.0.0.1:53387_solr-n_000000000= 2"} 127.0.0.1:53387_solr [junit4] 2> 59745 INFO (OverseerStateUpdate-72080559043248144-127.0.0= .1:53387_solr-n_0000000002) [n:127.0.0.1:53387_solr ] o.a.s.c.Overseer O= verseer Loop exiting : 127.0.0.1:53387_solr FATAL: command execution failed Command Close created at =09at hudson.remoting.Command.(Command.java:68) =09at hudson.remoting.Channel$CloseCommand.(Channel.java:1267) =09at hudson.remoting.Channel$CloseCommand.(Channel.java:1265) =09at hudson.remoting.Channel.close(Channel.java:1438) =09at hudson.remoting.Channel.close(Channel.java:1405) =09at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1272) Caused: hudson.remoting.Channel$OrderlyShutdown =09at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1273) =09at hudson.remoting.Channel$1.handle(Channel.java:565) =09at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(Synchron= ousCommandTransport.java:85) Caused: java.io.IOException: Backing channel 'Solaris VBOX' is disconnected= . =09at hudson.remoting.RemoteInvocationHandler.channelOrFail(RemoteInvocatio= nHandler.java:214) =09at hudson.remoting.RemoteInvocationHandler.invoke(RemoteInvocationHandle= r.java:283) =09at com.sun.proxy.$Proxy73.isAlive(Unknown Source) =09at hudson.Launcher$RemoteLauncher$ProcImpl.isAlive(Launcher.java:1150) =09at hudson.Launcher$RemoteLauncher$ProcImpl.join(Launcher.java:1142) =09at hudson.tasks.CommandInterpreter.join(CommandInterpreter.java:155) =09at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:109) =09at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66) =09at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) =09at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBui= ld.java:741) =09at hudson.model.Build$BuildExecution.build(Build.java:206) =09at hudson.model.Build$BuildExecution.doRun(Build.java:163) =09at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.j= ava:504) =09at hudson.model.Run.execute(Run.java:1818) =09at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) =09at hudson.model.ResourceController.execute(ResourceController.java:97) =09at hudson.model.Executor.run(Executor.java:429) FATAL: Unable to delete script file /var/tmp/jenkins6854046788539752081.sh Command Close created at =09at hudson.remoting.Command.(Command.java:68) =09at hudson.remoting.Channel$CloseCommand.(Channel.java:1267) =09at hudson.remoting.Channel$CloseCommand.(Channel.java:1265) =09at hudson.remoting.Channel.close(Channel.java:1438) =09at hudson.remoting.Channel.close(Channel.java:1405) =09at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1272) Caused: hudson.remoting.Channel$OrderlyShutdown =09at hudson.remoting.Channel$CloseCommand.execute(Channel.java:1273) =09at hudson.remoting.Channel$1.handle(Channel.java:565) =09at hudson.remoting.SynchronousCommandTransport$ReaderThread.run(Synchron= ousCommandTransport.java:85) Caused: hudson.remoting.ChannelClosedException: Channel "unknown": Remote c= all on Solaris VBOX failed. The channel is closing down or has closed down =09at hudson.remoting.Channel.call(Channel.java:950) =09at hudson.FilePath.act(FilePath.java:1069) =09at hudson.FilePath.act(FilePath.java:1058) =09at hudson.FilePath.delete(FilePath.java:1539) =09at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:123) =09at hudson.tasks.CommandInterpreter.perform(CommandInterpreter.java:66) =09at hudson.tasks.BuildStepMonitor$1.perform(BuildStepMonitor.java:20) =09at hudson.model.AbstractBuild$AbstractBuildExecution.perform(AbstractBui= ld.java:741) =09at hudson.model.Build$BuildExecution.build(Build.java:206) =09at hudson.model.Build$BuildExecution.doRun(Build.java:163) =09at hudson.model.AbstractBuild$AbstractBuildExecution.run(AbstractBuild.j= ava:504) =09at hudson.model.Run.execute(Run.java:1818) =09at hudson.model.FreeStyleBuild.run(FreeStyleBuild.java:43) =09at hudson.model.ResourceController.execute(ResourceController.java:97) =09at hudson.model.Executor.run(Executor.java:429) Build step 'Execute shell' marked build as failure ERROR: Step =E2=80=98Archive the artifacts=E2=80=99 failed: no workspace fo= r Lucene-Solr-8.x-Solaris #111 ERROR: Step =E2=80=98[Deprecated] Scan for compiler warnings=E2=80=99 faile= d: no workspace for Lucene-Solr-8.x-Solaris #111 ERROR: Step =E2=80=98Publish JUnit test result report=E2=80=99 failed: no w= orkspace for Lucene-Solr-8.x-Solaris #111 Email was triggered for: Failure - Any Sending email for trigger: Failure - Any ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ERROR: Solaris VBOX is offline; cannot locate ANT 1.8.2 Setting ANT_1_8_2_HOME=3D ------=_Part_132_769320926.1557175737784 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_132_769320926.1557175737784--