Return-Path: X-Original-To: archive-asf-public-internal@cust-asf2.ponee.io Delivered-To: archive-asf-public-internal@cust-asf2.ponee.io Received: from cust-asf.ponee.io (cust-asf.ponee.io [163.172.22.183]) by cust-asf2.ponee.io (Postfix) with ESMTP id 16411200B7F for ; Sun, 11 Sep 2016 17:40:31 +0200 (CEST) Received: by cust-asf.ponee.io (Postfix) id 14EE0160AC7; Sun, 11 Sep 2016 15:40:31 +0000 (UTC) Delivered-To: archive-asf-public@cust-asf.ponee.io Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by cust-asf.ponee.io (Postfix) with SMTP id 663FA160AB6 for ; Sun, 11 Sep 2016 17:40:28 +0200 (CEST) Received: (qmail 83007 invoked by uid 500); 11 Sep 2016 15:40:27 -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 82997 invoked by uid 99); 11 Sep 2016 15:40:26 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Sun, 11 Sep 2016 15:40:26 +0000 Received: from crius.apache.org (localhost [127.0.0.1]) by crius.apache.org (ASF Mail Server at crius.apache.org) with ESMTP id 4AF799C0373 for ; Sun, 11 Sep 2016 15:40:26 +0000 (UTC) Date: Sun, 11 Sep 2016 15:37:27 +0000 (UTC) From: Apache Jenkins Server To: dev@lucene.apache.org Message-ID: <1427717524.1339.1473608426310.JavaMail.jenkins@crius> In-Reply-To: <926488442.1195.1473545538540.JavaMail.jenkins@crius> References: <926488442.1195.1473545538540.JavaMail.jenkins@crius> Subject: [JENKINS] Lucene-Solr-Tests-6.x - Build # 447 - Still Unstable MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_1338_1027452324.1473608425978" X-Jenkins-Job: Lucene-Solr-Tests-6.x X-Jenkins-Result: UNSTABLE archived-at: Sun, 11 Sep 2016 15:40:31 -0000 ------=_Part_1338_1027452324.1473608425978 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable Build: https://builds.apache.org/job/Lucene-Solr-Tests-6.x/447/ 1 tests failed. FAILED: org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth Error Message: IOException occured when talking to server at: https://127.0.0.1:57982/solr Stack Trace: org.apache.solr.client.solrj.SolrServerException: IOException occured when = talking to server at: https://127.0.0.1:57982/solr =09at __randomizedtesting.SeedInfo.seed([E2BD62B168305F97:5ED314A3CC63DCED]= :0) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:606) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:261) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClie= nt.java:250) =09at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) =09at org.apache.solr.security.BasicAuthIntegrationTest.testBasicAuth(Basic= AuthIntegrationTest.java:158) =09at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) =09at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.= java:62) =09at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAcces= sorImpl.java:43) =09at java.lang.reflect.Method.invoke(Method.java:498) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(Randomized= Runner.java:1764) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(Random= izedRunner.java:871) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(Random= izedRunner.java:907) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(Rando= mizedRunner.java:921) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRu= leSetupTeardownChained.java:49) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleT= hreadAndTestName.java:48) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:367) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTa= sk(ThreadLeakControl.java:809) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(Threa= dLeakControl.java:460) =09at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(Ran= domizedRunner.java:880) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(Random= izedRunner.java:781) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(Random= izedRunner.java:816) =09at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(Random= izedRunner.java:827) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$= 1.evaluate(SystemPropertiesRestoreRule.java:57) =09at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBef= oreAfterRule.java:45) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStor= eClassName.java:41) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMeth= odsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRule= AssertionsRequired.java:53) =09at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFai= lure.java:47) =09at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(Test= RuleIgnoreAfterMaxFailures.java:64) =09at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIg= noreTestSuites.java:54) =09at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(St= atementAdapter.java:36) =09at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.= run(ThreadLeakControl.java:367) =09at java.lang.Thread.run(Thread.java:745) Caused by: javax.net.ssl.SSLHandshakeException: sun.security.validator.Vali= datorException: PKIX path building failed: sun.security.provider.certpath.S= unCertPathBuilderException: unable to find valid certification path to requ= ested target =09at sun.security.ssl.Alerts.getSSLException(Alerts.java:192) =09at sun.security.ssl.SSLSocketImpl.fatal(SSLSocketImpl.java:1949) =09at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:302) =09at sun.security.ssl.Handshaker.fatalSE(Handshaker.java:296) =09at sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.= java:1509) =09at sun.security.ssl.ClientHandshaker.processMessage(ClientHandshaker.jav= a:216) =09at sun.security.ssl.Handshaker.processLoop(Handshaker.java:979) =09at sun.security.ssl.Handshaker.process_record(Handshaker.java:914) =09at sun.security.ssl.SSLSocketImpl.readRecord(SSLSocketImpl.java:1062) =09at sun.security.ssl.SSLSocketImpl.performInitialHandshake(SSLSocketImpl.= java:1375) =09at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1403= ) =09at sun.security.ssl.SSLSocketImpl.startHandshake(SSLSocketImpl.java:1387= ) =09at org.apache.http.conn.ssl.SSLSocketFactory.connectSocket(SSLSocketFact= ory.java:543) =09at org.apache.http.conn.ssl.SSLSocketFactory.connectSocket(SSLSocketFact= ory.java:409) =09at org.apache.http.impl.conn.DefaultClientConnectionOperator.openConnect= ion(DefaultClientConnectionOperator.java:177) =09at org.apache.http.impl.conn.ManagedClientConnectionImpl.open(ManagedCli= entConnectionImpl.java:304) =09at org.apache.http.impl.client.DefaultRequestDirector.tryConnect(Default= RequestDirector.java:611) =09at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultReq= uestDirector.java:446) =09at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttp= Client.java:882) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:82) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:107) =09at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttp= Client.java:55) =09at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSo= lrClient.java:497) =09... 43 more Caused by: sun.security.validator.ValidatorException: PKIX path building fa= iled: sun.security.provider.certpath.SunCertPathBuilderException: unable to= find valid certification path to requested target =09at sun.security.validator.PKIXValidator.doBuild(PKIXValidator.java:387) =09at sun.security.validator.PKIXValidator.engineValidate(PKIXValidator.jav= a:292) =09at sun.security.validator.Validator.validate(Validator.java:260) =09at sun.security.ssl.X509TrustManagerImpl.validate(X509TrustManagerImpl.j= ava:324) =09at sun.security.ssl.X509TrustManagerImpl.checkTrusted(X509TrustManagerIm= pl.java:229) =09at sun.security.ssl.X509TrustManagerImpl.checkServerTrusted(X509TrustMan= agerImpl.java:124) =09at sun.security.ssl.ClientHandshaker.serverCertificate(ClientHandshaker.= java:1491) =09... 61 more Caused by: sun.security.provider.certpath.SunCertPathBuilderException: unab= le to find valid certification path to requested target =09at sun.security.provider.certpath.SunCertPathBuilder.build(SunCertPathBu= ilder.java:141) =09at sun.security.provider.certpath.SunCertPathBuilder.engineBuild(SunCert= PathBuilder.java:126) =09at java.security.cert.CertPathBuilder.build(CertPathBuilder.java:280) =09at sun.security.validator.PKIXValidator.doBuild(PKIXValidator.java:382) =09... 67 more Build Log: [...truncated 12539 lines...] [junit4] Suite: org.apache.solr.security.BasicAuthIntegrationTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Luce= ne-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.security.BasicAuth= IntegrationTest_E2BD62B168305F97-001/init-core-data-001 [junit4] 2> 3539168 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and c= lientAuth (false) via: @org.apache.solr.util.RandomizeSSL(reason=3D, ssl=3D= NaN, value=3DNaN, clientAuth=3DNaN) [junit4] 2> 3539173 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 3539176 INFO (Thread-4959) [ ] o.a.s.c.ZkTestServer cl= ient port:0.0.0.0/0.0.0.0:0 [junit4] 2> 3539176 INFO (Thread-4959) [ ] o.a.s.c.ZkTestServer St= arting server [junit4] 2> 3539280 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:505= 32 [junit4] 2> 3539280 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentia= lsProvider [junit4] 2> 3539281 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client t= o connect to ZooKeeper [junit4] 2> 3539282 INFO (zkCallback-4639-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@14= 51e062 name:ZooKeeperConnection Watcher:127.0.0.1:50532 got event WatchedEv= ent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539282 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected = to ZooKeeper [junit4] 2> 3539283 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvid= er [junit4] 2> 3539283 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/solr.xml [junit4] 2> 3539292 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /solr/clusterpr= ops.json [junit4] 2> 3539305 INFO (jetty-launcher-4638-thread-1) [ ] o.e.j.= s.Server jetty-9.3.8.v20160314 [junit4] 2> 3539307 INFO (jetty-launcher-4638-thread-2) [ ] o.e.j.= s.Server jetty-9.3.8.v20160314 [junit4] 2> 3539313 INFO (jetty-launcher-4638-thread-3) [ ] o.e.j.= s.Server jetty-9.3.8.v20160314 [junit4] 2> 3539336 INFO (jetty-launcher-4638-thread-2) [ ] o.e.j.= s.h.ContextHandler Started o.e.j.s.ServletContextHandler@4f723f55{/solr,nul= l,AVAILABLE} [junit4] 2> 3539339 INFO (jetty-launcher-4638-thread-2) [ ] o.e.j.= s.ServerConnector Started ServerConnector@4ee09c9b{SSL,[ssl, http/1.1]}{127= .0.0.1:48265} [junit4] 2> 3539339 INFO (jetty-launcher-4638-thread-2) [ ] o.e.j.= s.Server Started @3547579ms [junit4] 2> 3539339 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D48= 265} [junit4] 2> 3539340 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassL= oader@73d16e93 [junit4] 2> 3539340 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode2' [junit4] 2> 3539340 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3539340 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system = property or JNDI) [junit4] 2> 3539340 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539347 INFO (jetty-launcher-4638-thread-1) [ ] o.e.j.= s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7fae98e3{/solr,nul= l,AVAILABLE} [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.e.j.= s.ServerConnector Started ServerConnector@23b3f3f9{SSL,[ssl, http/1.1]}{127= .0.0.1:40607} [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.e.j.= s.Server Started @3547588ms [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D40= 607} [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassL= oader@73d16e93 [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode1' [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3539349 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system = property or JNDI) [junit4] 2> 3539350 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539357 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539358 INFO (zkCallback-4641-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1f= ddd802 name:ZooKeeperConnection Watcher:127.0.0.1:50532/solr got event Watc= hedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539358 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539358 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539358 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3539377 INFO (jetty-launcher-4638-thread-3) [ ] o.e.j.= s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5b333e5b{/solr,nul= l,AVAILABLE} [junit4] 2> 3539378 INFO (jetty-launcher-4638-thread-3) [ ] o.e.j.= s.ServerConnector Started ServerConnector@2b4970eb{SSL,[ssl, http/1.1]}{127= .0.0.1:57982} [junit4] 2> 3539378 INFO (jetty-launcher-4638-thread-3) [ ] o.e.j.= s.Server Started @3547618ms [junit4] 2> 3539378 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.s.e.JettySolrRunner Jetty properties: {hostContext=3D/solr, hostPort=3D57= 982} [junit4] 2> 3539379 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassL= oader@73d16e93 [junit4] 2> 3539379 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode3' [junit4] 2> 3539379 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3539379 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system = property or JNDI) [junit4] 2> 3539379 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539388 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539389 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539389 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode1/. [junit4] 2> 3539389 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.CoreContainer New CoreContainer 1086985245 [junit4] 2> 3539389 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.CoreContainer Loading cores into CoreContainer [instanceDir=3D/x1/jenkins= /jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2= /temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-0= 01/node1] [junit4] 2> 3539389 WARN (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace= /Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.security.Basi= cAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node1/lib to classpat= h: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/sol= r-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97= -001/tempDir-001/node1/lib [junit4] 2> 3539390 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : = https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000= ,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOf= Queue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSlee= pDelay : 5000,maxConnectionIdleTime : 40000, [junit4] 2> 3539391 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: s= ocketTimeout=3D340000&connTimeout=3D45000&retry=3Dtrue [junit4] 2> 3539391 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3539391 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFac= tory)] [junit4] 2> 3539392 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.ZkContainer Zookeeper client=3D127.0.0.1:50532/solr [junit4] 2> 3539392 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.ZkController zkHost includes chroot [junit4] 2> 3539392 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539394 INFO (zkCallback-4642-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5b= ce128 name:ZooKeeperConnection Watcher:127.0.0.1:50532/solr got event Watch= edEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539431 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539431 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539431 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539436 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3539437 INFO (zkCallback-4640-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@50= f4a323 name:ZooKeeperConnection Watcher:127.0.0.1:50532/solr got event Watc= hedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539440 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539440 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539440 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading... [junit4] 2> 3539646 INFO (zkCallback-4645-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@65= 78f1d name:ZooKeeperConnection Watcher:127.0.0.1:50532 got event WatchedEve= nt state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539646 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode3/. [junit4] 2> 3539646 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539646 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.CoreContainer New CoreContainer 2082641281 [junit4] 2> 3539646 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.CoreContainer Loading cores into CoreContainer [instanceDir=3D/x1/jenkins= /jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2= /temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-0= 01/node3] [junit4] 2> 3539646 INFO (jetty-launcher-4638-thread-1) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539646 WARN (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace= /Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.security.Basi= cAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node3/lib to classpat= h: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/sol= r-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97= -001/tempDir-001/node3/lib [junit4] 2> 3539647 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : = https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000= ,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOf= Queue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSlee= pDelay : 5000,maxConnectionIdleTime : 40000, [junit4] 2> 3539647 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apa= che.solr.cloud.ZkController$$Lambda$104/120540199@69624f56 [junit4] 2> 3539648 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: s= ocketTimeout=3D340000&connTimeout=3D45000&retry=3Dtrue [junit4] 2> 3539648 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jen= kins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/tem= p/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/n= ode2/. [junit4] 2> 3539648 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.CoreContainer New CoreContainer 1754549001 [junit4] 2> 3539648 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.CoreContainer Loading cores into CoreContainer [instanceDir=3D/x1/jenkins= /jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2= /temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-0= 01/node2] [junit4] 2> 3539648 WARN (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace= /Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr.security.Basi= cAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node2/lib to classpat= h: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/sol= r-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97= -001/tempDir-001/node2/lib [junit4] 2> 3539648 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : = https,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000= ,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOf= Queue : -1,fairnessPolicy : false,useRetries : false,connectionsEvictorSlee= pDelay : 5000,maxConnectionIdleTime : 40000, [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect t= o ZooKeeper [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFac= tory)] [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.ZkContainer Zookeeper client=3D127.0.0.1:50532/solr [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.ZkController zkHost includes chroot [junit4] 2> 3539649 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539651 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539651 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: s= ocketTimeout=3D340000&connTimeout=3D45000&retry=3Dtrue [junit4] 2> 3539654 INFO (zkCallback-4649-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@3d= 432e39 name:ZooKeeperConnection Watcher:127.0.0.1:50532 got event WatchedEv= ent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539654 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539654 INFO (jetty-launcher-4638-thread-3) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539655 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 3539655 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFac= tory)] [junit4] 2> 3539655 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.ZkContainer Zookeeper client=3D127.0.0.1:50532/solr [junit4] 2> 3539655 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ConnectionManager W= atcher org.apache.solr.common.cloud.ConnectionManager@1de651e9 name:ZooKeep= erConnection Watcher:127.0.0.1:50532/solr got event WatchedEvent state:Sync= Connected type:None path:null path:null type:None [junit4] 2> 3539657 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apa= che.solr.cloud.ZkController$$Lambda$104/120540199@36fd15c8 [junit4] 2> 3539655 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.ZkController zkHost includes chroot [junit4] 2> 3539657 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 3539657 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeepe= r [junit4] 2> 3539658 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 3539660 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect t= o ZooKeeper [junit4] 2> 3539662 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 3539665 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue= -work [junit4] 2> 3539666 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ConnectionManager W= atcher org.apache.solr.common.cloud.ConnectionManager@7bf582bc name:ZooKeep= erConnection Watcher:127.0.0.1:50532/solr got event WatchedEvent state:Sync= Connected type:None path:null path:null type:None [junit4] 2> 3539666 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeepe= r [junit4] 2> 3539667 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-r= unning [junit4] 2> 3539668 INFO (zkCallback-4653-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5f= 68ffae name:ZooKeeperConnection Watcher:127.0.0.1:50532 got event WatchedEv= ent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539668 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 3539669 INFO (jetty-launcher-4638-thread-2) [ ] o.a.s.= c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 3539669 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-c= ompleted [junit4] 2> 3539670 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.ZkController Added new OnReconnect listener org.apa= che.solr.cloud.ZkController$$Lambda$104/120540199@2ae49838 [junit4] 2> 3539670 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-c= ompleted [junit4] 2> 3539671 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-f= ailure [junit4] 2> 3539676 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect t= o ZooKeeper [junit4] 2> 3539700 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-f= ailure [junit4] 2> 3539701 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 3539702 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 3539703 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 3539703 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /collections [junit4] 2> 3539705 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 3539705 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 3539706 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 3539706 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 3539708 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 3539708 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 3539709 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeep= er...=20 [junit4] 2> 3539709 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeep= er...=20 [junit4] 2> 3539710 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlSche= me=3Dhttps} [junit4] 2> 3539710 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlSche= me=3Dhttps} [junit4] 2> 3539711 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper..= . (0) -> (0) [junit4] 2> 3539711 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper..= . (0) -> (0) [junit4] 2> 3539711 INFO (zkCallback-4654-thread-1-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ConnectionManager W= atcher org.apache.solr.common.cloud.ConnectionManager@15cc0f7f name:ZooKeep= erConnection Watcher:127.0.0.1:50532/solr got event WatchedEvent state:Sync= Connected type:None path:null path:null type:None [junit4] 2> 3539711 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeepe= r [junit4] 2> 3539714 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 3539716 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 3539717 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 3539717 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeep= er...=20 [junit4] 2> 3539718 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.Overseer Overseer (id=3Dnull) closing [junit4] 2> 3539718 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.ZkStateReader Loaded cluster properties: {urlSche= me=3Dhttps} [junit4] 2> 3539718 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.Overseer Overseer (id=3Dnull) closing [junit4] 2> 3539719 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.LeaderElector Joined leadership election with path:= /overseer_elect/election/96574239040208903-127.0.0.1:57982_solr-n_00000000= 00 [junit4] 2> 3539719 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper..= . (0) -> (0) [junit4] 2> 3539719 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.LeaderElector Joined leadership election with path:= /overseer_elect/election/96574239040208901-127.0.0.1:40607_solr-n_00000000= 01 [junit4] 2> 3539719 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader= 127.0.0.1:57982_solr [junit4] 2> 3539719 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 3539720 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.LeaderElector Watching path /overseer_elect/electio= n/96574239040208903-127.0.0.1:57982_solr-n_0000000000 to know if I could be= the leader [junit4] 2> 3539720 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/li= ve_nodes/127.0.0.1:40607_solr [junit4] 2> 3539720 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:4060= 7_solr [junit4] 2> 3539721 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.Overseer Overseer (id=3Dnull) closing [junit4] 2> 3539721 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.Overseer Overseer (id=3D96574239040208903-127.0.0.1= :57982_solr-n_0000000000) starting [junit4] 2> 3539722 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 3539722 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.LeaderElector Joined leadership election with path:= /overseer_elect/election/96574239040208905-127.0.0.1:48265_solr-n_00000000= 02 [junit4] 2> 3539722 INFO (zkCallback-4654-thread-1-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 3539722 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 3539723 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3539723 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.LeaderElector Watching path /overseer_elect/electio= n/96574239040208901-127.0.0.1:40607_solr-n_0000000001 to know if I could be= the leader [junit4] 2> 3539723 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.ZkController Publish node=3D127.0.0.1:48265_solr as= DOWN [junit4] 2> 3539724 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/li= ve_nodes/127.0.0.1:48265_solr [junit4] 2> 3539724 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:4826= 5_solr [junit4] 2> 3539727 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3539727 INFO (zkCallback-4654-thread-1-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 3539728 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 3539728 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 3539739 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3539740 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3539740 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 3539744 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping= setup for authorization module. [junit4] 2> 3539744 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 3539745 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions = underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/b= uild/solr-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B1= 68305F97-001/tempDir-001/node2/. [junit4] 2> 3539745 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 3539747 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 3539748 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 3539755 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping= setup for authorization module. [junit4] 2> 3539755 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 3539755 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions = underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/b= uild/solr-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B1= 68305F97-001/tempDir-001/node1/. [junit4] 2> 3539755 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 3539756 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.s.SolrDispatchFilter user.dir=3D/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 3539756 INFO (jetty-launcher-4638-thread-2) [n:127.0.0.1:= 48265_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 3539757 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.s.SolrDispatchFilter user.dir=3D/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 3539757 INFO (jetty-launcher-4638-thread-1) [n:127.0.0.1:= 40607_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 3539759 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting Overseer= AutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=3D10000 autoRepl= icaFailoverWaitAfterExpiration=3D30000 autoReplicaFailoverBadNodeExpiration= =3D60000 [junit4] 2> 3539759 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= Starting to work on the main queue [junit4] 2> 3539761 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStat= eReader Updated live nodes from ZooKeeper... (2) -> (2) [junit4] 2> 3539762 INFO (OverseerCollectionConfigSetProcessor-965742= 39040208903-127.0.0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ]= o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 3539762 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.ZkController Publish node=3D127.0.0.1:57982_solr as= DOWN [junit4] 2> 3539763 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 1, message =3D { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:48265_solr"} current state versio= n: 0 [junit4] 2> 3539763 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/li= ve_nodes/127.0.0.1:57982_solr [junit4] 2> 3539764 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:5798= 2_solr [junit4] 2> 3539764 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.NodeMu= tator DownNode state invoked for node: 127.0.0.1:48265_solr [junit4] 2> 3539765 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 3539765 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 3539765 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3539765 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3539766 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 3539766 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (2) -> (3) [junit4] 2> 3539774 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping= setup for authorization module. [junit4] 2> 3539774 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 3539775 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.CorePropertiesLocator Looking for core definitions = underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/b= uild/solr-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B1= 68305F97-001/tempDir-001/node3/. [junit4] 2> 3539775 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions [junit4] 2> 3539775 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 2, message =3D { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:57982_solr"} current state versio= n: 0 [junit4] 2> 3539776 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.NodeMu= tator DownNode state invoked for node: 127.0.0.1:57982_solr [junit4] 2> 3539776 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.s.SolrDispatchFilter user.dir=3D/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2 [junit4] 2> 3539776 INFO (jetty-launcher-4638-thread-3) [n:127.0.0.1:= 57982_solr ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 3539780 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentia= lsProvider [junit4] 2> 3539781 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client t= o connect to ZooKeeper [junit4] 2> 3539781 INFO (zkCallback-4658-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@15= 6f06a7 name:ZooKeeperConnection Watcher:127.0.0.1:50532 got event WatchedEv= ent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539781 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected = to ZooKeeper [junit4] 2> 3539782 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvid= er [junit4] 2> 3539788 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentia= lsProvider [junit4] 2> 3539793 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client t= o connect to ZooKeeper [junit4] 2> 3539793 INFO (zkCallback-4661-thread-1) [ ] o.a.s.c.c.= ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@73= 824a21 name:ZooKeeperConnection Watcher:127.0.0.1:50532/solr got event Watc= hedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 3539793 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected = to ZooKeeper [junit4] 2> 3539793 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvid= er [junit4] 2> 3539794 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ZkStateReader Updating cluster state f= rom ZooKeeper...=20 [junit4] 2> 3539794 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ZkStateReader Loaded cluster propertie= s: {urlScheme=3Dhttps} [junit4] 2> 3539794 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from = ZooKeeper... (0) -> (3) [junit4] 2> 3539796 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf/s= chema.xml [junit4] 2> 3539806 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf/s= olrconfig.xml [junit4] 2> 3539873 INFO (qtp2043262125-22486) [n:127.0.0.1:40607_sol= r ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with = params replicationFactor=3D1&collection.configName=3Dconf&name=3DauthCollec= tion&action=3DCREATE&numShards=3D3&wt=3Djavabin&version=3D2 and sendToOCPQu= eue=3Dtrue [junit4] 2> 3539882 INFO (OverseerCollectionConfigSetProcessor-965742= 39040208903-127.0.0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ]= o.a.s.c.OverseerTaskProcessor Overseer Collection Message Handler: Get the= message id:/overseer/collection-queue-work/qn-0000000000 message:{ [junit4] 2> "name":"authCollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"conf", [junit4] 2> "numShards":"3", [junit4] 2> "stateFormat":"2", [junit4] 2> "operation":"create"} [junit4] 2> 3539883 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.OverseerCo= llectionMessageHandler OverseerCollectionMessageHandler.processMessage : cr= eate , { [junit4] 2> "name":"authCollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"conf", [junit4] 2> "numShards":"3", [junit4] 2> "stateFormat":"2", [junit4] 2> "operation":"create"} [junit4] 2> 3539883 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.CreateColl= ectionCmd Create collection authCollection [junit4] 2> 3539883 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.OverseerCo= llectionMessageHandler creating collections conf node /collections/authColl= ection=20 [junit4] 2> 3539884 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.SolrZkCl= ient makePath: /collections/authCollection [junit4] 2> 3539885 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader A col= lections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged= path:/collections], has occurred - updating... [junit4] 2> 3539886 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader A col= lections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged= path:/collections], has occurred - updating... [junit4] 2> 3539886 INFO (zkCallback-4652-thread-2-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A col= lections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged= path:/collections], has occurred - updating... [junit4] 2> 3539887 INFO (zkCallback-4661-thread-1) [ ] o.a.s.c.c.= ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:= NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 3539893 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 1, message =3D { [junit4] 2> "name":"authCollection", [junit4] 2> "fromApi":"true", [junit4] 2> "replicationFactor":"1", [junit4] 2> "collection.configName":"conf", [junit4] 2> "numShards":"3", [junit4] 2> "stateFormat":"2", [junit4] 2> "operation":"create"} current state version: 0 [junit4] 2> 3539893 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.Cluste= rStateMutator building a new cName: authCollection [junit4] 2> 3539894 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.ZkStat= eWriter going to create_collection /collections/authCollection/state.json [junit4] 2> 3539995 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.CreateColl= ectionCmd Creating SolrCores for new collection authCollection, shardNames = [shard1, shard2, shard3] , replicationFactor : 1 [junit4] 2> 3539996 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.CreateColl= ectionCmd Creating core authCollection_shard3_replica1 as part of shard sha= rd3 of collection authCollection on 127.0.0.1:40607_solr [junit4] 2> 3539996 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.CreateColl= ectionCmd Creating core authCollection_shard2_replica1 as part of shard sha= rd2 of collection authCollection on 127.0.0.1:48265_solr [junit4] 2> 3539996 INFO (OverseerThreadFactory-9335-thread-1-process= ing-n:127.0.0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.CreateColl= ectionCmd Creating core authCollection_shard1_replica1 as part of shard sha= rd1 of collection authCollection on 127.0.0.1:57982_solr [junit4] 2> 3540048 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r ] o.a.s.h.a.CoreAdminOperation core create command qt=3D/admin/cores&c= ollection.configName=3Dconf&name=3DauthCollection_shard3_replica1&action=3D= CREATE&numShards=3D3&collection=3DauthCollection&shard=3Dshard3&wt=3Djavabi= n&version=3D2 [junit4] 2> 3540048 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=3DauthCollectio= n_shard3_replica1, collection.configName=3Dconf, config=3Dsolrconfig.xml, t= ransient=3Dfalse, schema=3Dschema.xml, loadOnStartup=3Dtrue, configSetPrope= rties=3Dconfigsetprops.json, collection=3DauthCollection, numShards=3D3, da= taDir=3Ddata/, shard=3Dshard3} [junit4] 2> 3540052 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller publishing state=3Ddown [junit4] 2> 3540053 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 1, message =3D { [junit4] 2> "core":"authCollection_shard3_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:40607/solr", [junit4] 2> "node_name":"127.0.0.1:40607_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 3540053 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.Replic= aMutator Update state numShards=3D3 message=3D{ [junit4] 2> "core":"authCollection_shard3_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:40607/solr", [junit4] 2> "node_name":"127.0.0.1:40607_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard3", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} [junit4] 2> 3540065 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller Registering watch for collection authCollection [junit4] 2> 3540066 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.c.Zk= StateReader Add data for [authCollection] ver [0] [junit4] 2> 3540069 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller look for our core node name [junit4] 2> 3540094 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r ] o.a.s.h.a.CoreAdminOperation core create command qt=3D/admin/cores&c= ollection.configName=3Dconf&name=3DauthCollection_shard1_replica1&action=3D= CREATE&numShards=3D3&collection=3DauthCollection&shard=3Dshard1&wt=3Djavabi= n&version=3D2 [junit4] 2> 3540095 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=3DauthCollectio= n_shard1_replica1, collection.configName=3Dconf, config=3Dsolrconfig.xml, t= ransient=3Dfalse, schema=3Dschema.xml, loadOnStartup=3Dtrue, configSetPrope= rties=3Dconfigsetprops.json, collection=3DauthCollection, numShards=3D3, da= taDir=3Ddata/, shard=3Dshard1} [junit4] 2> 3540095 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller publishing state=3Ddown [junit4] 2> 3540096 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller Registering watch for collection authCollection [junit4] 2> 3540096 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.c.Zk= StateReader Add data for [authCollection] ver [0] [junit4] 2> 3540099 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 1, message =3D { [junit4] 2> "core":"authCollection_shard1_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57982/solr", [junit4] 2> "node_name":"127.0.0.1:57982_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 3540099 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.Replic= aMutator Update state numShards=3D3 message=3D{ [junit4] 2> "core":"authCollection_shard1_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:57982/solr", [junit4] 2> "node_name":"127.0.0.1:57982_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard1", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} [junit4] 2> 3540102 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller look for our core node name [junit4] 2> 3540115 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r ] o.a.s.h.a.CoreAdminOperation core create command qt=3D/admin/cores&c= ollection.configName=3Dconf&name=3DauthCollection_shard2_replica1&action=3D= CREATE&numShards=3D3&collection=3DauthCollection&shard=3Dshard2&wt=3Djavabi= n&version=3D2 [junit4] 2> 3540115 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=3DauthCollectio= n_shard2_replica1, collection.configName=3Dconf, config=3Dsolrconfig.xml, t= ransient=3Dfalse, schema=3Dschema.xml, loadOnStartup=3Dtrue, configSetPrope= rties=3Dconfigsetprops.json, collection=3DauthCollection, numShards=3D3, da= taDir=3Ddata/, shard=3Dshard2} [junit4] 2> 3540120 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller publishing state=3Ddown [junit4] 2> 3540122 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.Overseer= processMessage: queueSize: 1, message =3D { [junit4] 2> "core":"authCollection_shard2_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:48265/solr", [junit4] 2> "node_name":"127.0.0.1:48265_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 3540122 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.Replic= aMutator Update state numShards=3D3 message=3D{ [junit4] 2> "core":"authCollection_shard2_replica1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"https://127.0.0.1:48265/solr", [junit4] 2> "node_name":"127.0.0.1:48265_solr", [junit4] 2> "numShards":"3", [junit4] 2> "state":"down", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"authCollection", [junit4] 2> "operation":"state"} [junit4] 2> 3540122 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller Registering watch for collection authCollection [junit4] 2> 3540123 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.c.Zk= StateReader Add data for [authCollection] ver [0] [junit4] 2> 3540129 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller look for our core node name [junit4] 2> 3540224 INFO (OverseerStateUpdate-96574239040208903-127.0= .0.1:57982_solr-n_0000000000) [n:127.0.0.1:57982_solr ] o.a.s.c.o.ZkStat= eWriter going to update_collection /collections/authCollection/state.json v= ersion: 0 [junit4] 2> 3540225 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader A clu= ster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged p= ath:/collections/authCollection/state.json] for collection [authCollection]= has occurred - updating... (live nodes size: [3]) [junit4] 2> 3540225 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader A clu= ster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged p= ath:/collections/authCollection/state.json] for collection [authCollection]= has occurred - updating... (live nodes size: [3]) [junit4] 2> 3540225 INFO (zkCallback-4646-thread-1-processing-n:127.0= .0.1:40607_solr) [n:127.0.0.1:40607_solr ] o.a.s.c.c.ZkStateReader Updat= ing data for [authCollection] from [0] to [1] [junit4] 2> 3540226 INFO (zkCallback-4654-thread-2-processing-n:127.0= .0.1:48265_solr) [n:127.0.0.1:48265_solr ] o.a.s.c.c.ZkStateReader Updat= ing data for [authCollection] from [0] to [1] [junit4] 2> 3540226 INFO (zkCallback-4652-thread-2-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A clu= ster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged p= ath:/collections/authCollection/state.json] for collection [authCollection]= has occurred - updating... (live nodes size: [3]) [junit4] 2> 3540226 INFO (zkCallback-4652-thread-2-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader Updat= ing data for [authCollection] from [0] to [1] [junit4] 2> 3541072 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller waiting to find shard id in clusterstate for authCollection_shard3= _replica1 [junit4] 2> 3541072 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller Check for collection zkNode:authCollection [junit4] 2> 3541072 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.ZkCo= ntroller Collection zkNode exists [junit4] 2> 3541072 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.c.Zk= StateReader Load collection config from: [/collections/authCollection] [junit4] 2> 3541073 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.c.Zk= StateReader path=3D[/collections/authCollection] [configName]=3D[conf] spec= ified config exists in ZooKeeper [junit4] 2> 3541073 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= ResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr= .security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node1/a= uthCollection_shard3_replica1' [junit4] 2> 3541073 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= ResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3541073 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= ResourceLoader solr home defaulted to 'solr/' (could not find system proper= ty or JNDI) [junit4] 2> 3541075 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Conf= ig loaded config solrconfig.xml with version 0=20 [junit4] 2> 3541078 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= Config current version of requestparams : -1 [junit4] 2> 3541080 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= Config Using Lucene MatchVersion: 6.3.0 [junit4] 2> 3541091 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Solr= Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 3541095 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.s.Inde= xSchema [authCollection_shard3_replica1] Schema name=3Dminimal [junit4] 2> 3541101 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.s.Inde= xSchema unique key field: id [junit4] 2> 3541103 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Conf= igSetProperties Did not find ConfigSet properties, assuming default propert= ies: Can't find resource 'configsetprops.json' in classpath or '/configs/co= nf', cwd=3D/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/b= uild/solr-core/test/J2 [junit4] 2> 3541103 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 x:authCollection_shard3_replica1] o.a.s.c.Core= Container Creating SolrCore 'authCollection_shard3_replica1' using configur= ation from collection authCollection [junit4] 2> 3541103 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 3541104 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore [[authCollection_shard3_replica1] ] Opening new SolrCore a= t [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/sol= r-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97= -001/tempDir-001/node1/authCollection_shard3_replica1], dataDir=3D[/x1/jenk= ins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test= /J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDi= r-001/node1/./authCollection_shard3_replica1/data/] [junit4] 2> 3541104 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore JMX monitoring not detected for core: authCollection_shard= 3_replica1 [junit4] 2> 3541104 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller waiting to find shard id in clusterstate for authCollection_shard1= _replica1 [junit4] 2> 3541104 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller Check for collection zkNode:authCollection [junit4] 2> 3541104 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 1/./authCollection_shard3_replica1/data/snapshot_metadata [junit4] 2> 3541104 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.ZkCo= ntroller Collection zkNode exists [junit4] 2> 3541104 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file..= . [junit4] 2> 3541104 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.c.Zk= StateReader Load collection config from: [/collections/authCollection] [junit4] 2> 3541105 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 1/./authCollection_shard3_replica1/data [junit4] 2> 3541105 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.c.Zk= StateReader path=3D[/collections/authCollection] [configName]=3D[conf] spec= ified config exists in ZooKeeper [junit4] 2> 3541105 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= ResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr= .security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node3/a= uthCollection_shard1_replica1' [junit4] 2> 3541105 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= ResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3541105 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= ResourceLoader solr home defaulted to 'solr/' (could not find system proper= ty or JNDI) [junit4] 2> 3541109 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Conf= ig loaded config solrconfig.xml with version 0=20 [junit4] 2> 3541112 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore New index directory detected: old=3Dnull new=3D/x1/jenkins= /jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2= /temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-0= 01/node1/./authCollection_shard3_replica1/data/index/ [junit4] 2> 3541112 WARN (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore [authCollection_shard3_replica1] Solr index directory '/x1= /jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core= /test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/t= empDir-001/node1/./authCollection_shard3_replica1/data/index' doesn't exist= . Creating new index... [junit4] 2> 3541113 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 1/./authCollection_shard3_replica1/data/index [junit4] 2> 3541113 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3D1 [junit4] 2> =09commit{dir=3DMockDirectoryWrapper(RAMDirectory@12aa10a0= lockFactory=3Dorg.apache.lucene.store.SingleInstanceLockFactory@682ed4e5),= segFN=3Dsegments_1,generation=3D1} [junit4] 2> 3541113 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrDeletionPolicy newest commit generation =3D 1 [junit4] 2> 3541116 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= Config current version of requestparams : -1 [junit4] 2> 3541118 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= Config Using Lucene MatchVersion: 6.3.0 [junit4] 2> 3541127 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Solr= Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 3541132 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller waiting to find shard id in clusterstate for authCollection_shard2= _replica1 [junit4] 2> 3541132 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller Check for collection zkNode:authCollection [junit4] 2> 3541134 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.s.Inde= xSchema [authCollection_shard1_replica1] Schema name=3Dminimal [junit4] 2> 3541137 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.ZkCo= ntroller Collection zkNode exists [junit4] 2> 3541137 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.c.Zk= StateReader Load collection config from: [/collections/authCollection] [junit4] 2> 3541138 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.c.Zk= StateReader path=3D[/collections/authCollection] [configName]=3D[conf] spec= ified config exists in ZooKeeper [junit4] 2> 3541138 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= ResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-s= lave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/solr= .security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node2/a= uthCollection_shard2_replica1' [junit4] 2> 3541138 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= ResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 3541138 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= ResourceLoader solr home defaulted to 'solr/' (could not find system proper= ty or JNDI) [junit4] 2> 3541140 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Conf= ig loaded config solrconfig.xml with version 0=20 [junit4] 2> 3541141 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.s.Inde= xSchema unique key field: id [junit4] 2> 3541144 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= Config current version of requestparams : -1 [junit4] 2> 3541144 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Conf= igSetProperties Did not find ConfigSet properties, assuming default propert= ies: Can't find resource 'configsetprops.json' in classpath or '/configs/co= nf', cwd=3D/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/b= uild/solr-core/test/J2 [junit4] 2> 3541144 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 x:authCollection_shard1_replica1] o.a.s.c.Core= Container Creating SolrCore 'authCollection_shard1_replica1' using configur= ation from collection authCollection [junit4] 2> 3541145 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 3541145 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore [[authCollection_shard1_replica1] ] Opening new SolrCore a= t [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/sol= r-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97= -001/tempDir-001/node3/authCollection_shard1_replica1], dataDir=3D[/x1/jenk= ins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test= /J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDi= r-001/node3/./authCollection_shard1_replica1/data/] [junit4] 2> 3541145 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore JMX monitoring not detected for core: authCollection_shard= 1_replica1 [junit4] 2> 3541145 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 3/./authCollection_shard1_replica1/data/snapshot_metadata [junit4] 2> 3541146 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.s.SolrSnapshotMetaDataManager Loading from snapshot metadata file..= . [junit4] 2> 3541146 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= Config Using Lucene MatchVersion: 6.3.0 [junit4] 2> 3541146 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 3/./authCollection_shard1_replica1/data [junit4] 2> 3541157 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Solr= Config Loaded SolrConfig: solrconfig.xml [junit4] 2> 3541158 INFO (OldIndexDirectoryCleanupThreadForCore-authC= ollection_shard3_replica1) [n:127.0.0.1:40607_solr c:authCollection s:shard= 3 r:core_node1 x:authCollection_shard3_replica1] o.a.s.c.SolrCore Looking f= or old index directories to cleanup for core authCollection_shard3_replica1= in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/so= lr-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F9= 7-001/tempDir-001/node1/./authCollection_shard3_replica1/data/ [junit4] 2> 3541158 WARN (OldIndexDirectoryCleanupThreadForCore-authC= ollection_shard3_replica1) [n:127.0.0.1:40607_solr c:authCollection s:shard= 3 r:core_node1 x:authCollection_shard3_replica1] o.a.s.c.DirectoryFactory /= x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-co= re/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001= /tempDir-001/node1/./authCollection_shard3_replica1/data/ does not point to= a valid data directory; skipping clean-up of old index directories. [junit4] 2> 3541159 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore New index directory detected: old=3Dnull new=3D/x1/jenkins= /jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2= /temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-0= 01/node3/./authCollection_shard1_replica1/data/index/ [junit4] 2> 3541159 WARN (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore [authCollection_shard1_replica1] Solr index directory '/x1= /jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core= /test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/t= empDir-001/node3/./authCollection_shard1_replica1/data/index' doesn't exist= . Creating new index... [junit4] 2> 3541159 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkin= s-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp/s= olr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001/tempDir-001/node= 3/./authCollection_shard1_replica1/data/index [junit4] 2> 3541167 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.s.Inde= xSchema [authCollection_shard2_replica1] Schema name=3Dminimal [junit4] 2> 3541169 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.s.Inde= xSchema unique key field: id [junit4] 2> 3541169 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creatin= g implicit default [junit4] 2> 3541171 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541172 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=3D1 [junit4] 2> =09commit{dir=3DMockDirectoryWrapper(RAMDirectory@4d81760a= lockFactory=3Dorg.apache.lucene.store.SingleInstanceLockFactory@4e3b1c6b),= segFN=3Dsegments_1,generation=3D1} [junit4] 2> 3541172 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541172 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrDeletionPolicy newest commit generation =3D 1 [junit4] 2> 3541174 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creatin= g implicit default [junit4] 2> 3541175 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541176 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541177 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541177 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541176 INFO (OldIndexDirectoryCleanupThreadForCore-authC= ollection_shard1_replica1) [n:127.0.0.1:57982_solr c:authCollection s:shard= 1 r:core_node2 x:authCollection_shard1_replica1] o.a.s.c.SolrCore Looking f= or old index directories to cleanup for core authCollection_shard1_replica1= in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/so= lr-core/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F9= 7-001/tempDir-001/node3/./authCollection_shard1_replica1/data/ [junit4] 2> 3541178 WARN (OldIndexDirectoryCleanupThreadForCore-authC= ollection_shard1_replica1) [n:127.0.0.1:57982_solr c:authCollection s:shard= 1 r:core_node2 x:authCollection_shard1_replica1] o.a.s.c.DirectoryFactory /= x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-co= re/test/J2/temp/solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001= /tempDir-001/node3/./authCollection_shard1_replica1/data/ does not point to= a valid data directory; skipping clean-up of old index directories. [junit4] 2> 3541179 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/json/docs,/= admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/upda= te/csv,/sql,/graph,/select,/admin/segments,/admin/system,/replication,/conf= ig,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin= /file,/terms [junit4] 2> 3541179 INFO (qtp1310325822-22498) [n:127.0.0.1:57982_sol= r c:authCollection s:shard1 r:core_node2 x:authCollection_shard1_replica1] = o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.sta= ts.LocalStatsCache [junit4] 2> 3541183 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541188 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=3D60 [junit4] 2> 3541189 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,/update/json/docs,/= admin/luke,/export,/get,/admin/properties,/update/json,/admin/threads,/upda= te/csv,/sql,/graph,/select,/admin/segments,/admin/system,/replication,/conf= ig,/stream,/schema,/admin/plugins,/admin/logging,/admin/ping,/update,/admin= /file,/terms [junit4] 2> 3541189 INFO (qtp2043262125-22481) [n:127.0.0.1:40607_sol= r c:authCollection s:shard3 r:core_node1 x:authCollection_shard3_replica1] = o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.sta= ts.LocalStatsCache [junit4] 2> 3541191 INFO (qtp1591475240-22476) [n:127.0.0.1:48265_sol= r c:authCollection s:shard2 x:authCollection_shard2_replica1] o.a.s.c.Conf= igSetProperties Did not find ConfigSet properties, assuming default propert= ies: Can't find resource 'configsetprops.json' in classpath or '/configs/co= nf', cwd=3D/x1/jenkins/jenkins-slave/workspac [...truncated too long message...] junit4] 2> =09at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadP= oolExecutor.execute(ExecutorUtil.java:214) [junit4] 2> =09at java.util.concurrent.AbstractExecutorService.submit(= AbstractExecutorService.java:112) [junit4] 2> =09at org.apache.solr.common.cloud.SolrZkClient$3.process(= SolrZkClient.java:266) [junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.processE= vent(ClientCnxn.java:522) [junit4] 2> =09at org.apache.zookeeper.ClientCnxn$EventThread.run(Clie= ntCnxn.java:498) [junit4] 2> 3546677 INFO (jetty-launcher-4638-thread-1) [ ] o.e.j.= s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@7fae98e3{/solr,nul= l,UNAVAILABLE} [junit4] 2> 3546678 INFO (zkCallback-4666-thread-2-processing-n:127.0= .0.1:50614_solr) [n:127.0.0.1:50614_solr ] o.a.s.c.LeaderElector Watchin= g path /overseer_elect/election/96574239040208903-127.0.0.1:57982_solr-n_00= 00000000 to know if I could be the leader [junit4] 2> 3546679 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader Updat= ed live nodes from ZooKeeper... (3) -> (2) [junit4] 2> 3546680 INFO (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 3546680 INFO (zkCallback-4666-thread-2-processing-n:127.0= .0.1:50614_solr) [n:127.0.0.1:50614_solr ] o.a.s.c.c.ZkStateReader A liv= e node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged p= ath:/live_nodes], has occurred - updating... (live nodes size: [2]) [junit4] 2> 3546680 WARN (zkCallback-4666-thread-2-processing-n:127.0= .0.1:50614_solr) [n:127.0.0.1:50614_solr ] o.a.s.c.c.ZkStateReader ZooKe= eper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode =3D Sess= ion expired for /live_nodes] [junit4] 2> 3546681 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ = ] o.a.z.s.NIOServerCnxn caught end of stream exception [junit4] 2> EndOfStreamException: Unable to read additional data from = client sessionid 0x15719c23c720007, likely client has closed socket [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOSe= rverCnxn.java:228) [junit4] 2> =09at org.apache.zookeeper.server.NIOServerCnxnFactory.run= (NIOServerCnxnFactory.java:208) [junit4] 2> =09at java.lang.Thread.run(Thread.java:745) [junit4] 2> 3546682 INFO (jetty-launcher-4638-thread-3) [ ] o.e.j.= s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@459fa8dc{/solr,nul= l,UNAVAILABLE} [junit4] 2> 3548180 WARN (zkCallback-4652-thread-1-processing-n:127.0= .0.1:57982_solr) [n:127.0.0.1:57982_solr ] o.a.s.c.c.ZkStateReader ZooKe= eper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode =3D Sess= ion expired for /live_nodes] [junit4] 2> 3548180 INFO (jetty-launcher-4638-thread-2) [ ] o.e.j.= s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@5b333e5b{/solr,nul= l,UNAVAILABLE} [junit4] 2> 3548185 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1:505= 32 50532 [junit4] 2> 3548289 INFO (Thread-4959) [ ] o.a.s.c.ZkTestServer co= nnecting to 127.0.0.1:50532 50532 [junit4] 2> 3548289 WARN (Thread-4959) [ ] o.a.s.c.ZkTestServer Wa= tch limit violations:=20 [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2>=20 [junit4] 2> =095=09/solr/aliases.json [junit4] 2> =094=09/solr/security.json [junit4] 2> =094=09/solr/configs/conf [junit4] 2>=20 [junit4] 2> Maximum concurrent data watches above limit: [junit4] 2>=20 [junit4] 2> =095=09/solr/clusterstate.json [junit4] 2> =095=09/solr/clusterprops.json [junit4] 2> =094=09/solr/collections/authCollection/state.json [junit4] 2> =092=09/solr/overseer_elect/election/96574239040208903-127= .0.0.1:57982_solr-n_0000000000 [junit4] 2> =092=09/solr/overseer_elect/election/96574239040208901-127= .0.0.1:40607_solr-n_0000000001 [junit4] 2>=20 [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2>=20 [junit4] 2> =0913=09/solr/overseer/queue [junit4] 2> =097=09/solr/overseer/collection-queue-work [junit4] 2> =095=09/solr/collections [junit4] 2> =094=09/solr/live_nodes [junit4] 2> =093=09/solr/overseer/queue-work [junit4] 2>=20 [junit4] 2> 3548290 INFO (SUITE-BasicAuthIntegrationTest-seed#[E2BD62= B168305F97]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: /x1/jenkins/jenk= ins-slave/workspace/Lucene-Solr-Tests-6.x/solr/build/solr-core/test/J2/temp= /solr.security.BasicAuthIntegrationTest_E2BD62B168305F97-001 [junit4] 2> Sep 11, 2016 2:59:11 PM com.carrotsearch.randomizedtesting= .ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thre= ad(s). [junit4] 2> NOTE: test params are: codec=3DAsserting(Lucene62): {}, do= cValues:{}, maxPointsInLeafNode=3D1001, maxMBSortInHeap=3D6.663034698441542= , sim=3DClassicSimilarity, locale=3Del-GR, timezone=3DUS/Indiana-Starke [junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation 1.8= .0_102 (64-bit)/cpus=3D4,threads=3D1,free=3D214259184,total=3D524812288 [junit4] 2> NOTE: All tests run in this JVM: [TestSolrConfigHandler, T= estAnalyzedSuggestions, TestNonDefinedSimilarityFactory, TestHdfsUpdateLog,= TestWriterPerf, TestSolrConfigHandlerCloud, SuggesterTest, TestRestManager= , TestDocTermOrds, TestDynamicFieldResource, TestJettySolrRunner, StressHdf= sTest, TestImplicitCoreProperties, SimpleMLTQParserTest, SolrCoreCheckLockO= nStartupTest, HdfsRestartWhileUpdatingTest, DistributedFacetPivotWhiteBoxTe= st, LeaderElectionTest, DateRangeFieldTest, TestXIncludeConfig, TestConfigS= etProperties, HdfsNNFailoverTest, SharedFSAutoReplicaFailoverTest, DataDriv= enBlockJoinTest, TestReload, RecoveryAfterSoftCommitTest, PluginInfoTest, T= estSchemaResource, TestNRTOpen, UpdateParamsTest, PrimitiveFieldTypeTest, H= LLUtilTest, DistributedSuggestComponentTest, FullSolrCloudDistribCmdsTest, = TestGroupingSearch, DocValuesMultiTest, CdcrReplicationHandlerTest, TestCon= fig, DebugComponentTest, TestFieldCacheSanityChecker, CoreAdminRequestStatu= sTest, CollectionReloadTest, TestGeoJSONResponseWriter, TestChildDocTransfo= rmer, BigEndianAscendingWordDeserializerTest, PingRequestHandlerTest, TestL= MJelinekMercerSimilarityFactory, SolrTestCaseJ4Test, BufferStoreTest, ZkSta= teWriterTest, TestRawTransformer, TestOverriddenPrefixQueryForCustomFieldTy= pe, TestCryptoKeys, DistribJoinFromCollectionTest, TestSolrQueryParser, Bad= IndexSchemaTest, TestSolrDeletionPolicy1, TestMergePolicyConfig, RecoveryZk= Test, AddBlockUpdateTest, SpellPossibilityIteratorTest, DocExpirationUpdate= ProcessorFactoryTest, TestExactSharedStatsCache, LukeRequestHandlerTest, Te= stMacroExpander, SolrCLIZkUtilsTest, VMParamsZkACLAndCredentialsProvidersTe= st, SOLR749Test, TestSolrCoreSnapshots, TestSmileRequest, ResponseLogCompon= entTest, TestReversedWildcardFilterFactory, TestXmlQParser, FieldMutatingUp= dateProcessorTest, BaseCdcrDistributedZkTest, TestAuthenticationFramework, = SimpleFacetsTest, TestSort, TestExpandComponent, SolrPluginUtilsTest, TestE= xclusionRuleCollectionAccess, OpenExchangeRatesOrgProviderTest, TestFieldTy= peCollectionResource, DOMUtilTest, TestCustomSort, CircularListTest, Curren= cyFieldXmlFileTest, TestReloadDeadlock, NoCacheHeaderTest, SecurityConfHand= lerTest, OverseerTest, TestSolrJ, TestMinMaxOnMultiValuedField, TestCollati= onField, WrapperMergePolicyFactoryTest, DeleteNodeTest, TestSerializedLucen= eMatchVersion, TestSubQueryTransformerDistrib, TestManagedSchema, TestGraph= TermsQParserPlugin, BasicDistributedZkTest, ChaosMonkeySafeLeaderTest, Basi= cDistributedZk2Test, UnloadDistributedZkTest, LeaderElectionIntegrationTest= , BasicZkTest, TestReplicationHandler, TestRandomFaceting, TestZkChroot, Zk= CLITest, ShardRoutingCustomTest, TestDistributedSearch, SolrCoreTest, Direc= tUpdateHandlerTest, HighlighterTest, ShowFileRequestHandlerTest, SignatureU= pdateProcessorFactoryTest, TestExtendedDismaxParser, TestFoldingMultitermQu= ery, SuggesterTSTTest, TestStressLucene, TestTrie, SuggesterWFSTTest, WordB= reakSolrSpellCheckerTest, TestWordDelimiterFilterFactory, TestRemoteStreami= ng, DistanceFunctionTest, SolrInfoMBeanTest, IndexBasedSpellCheckerTest, Te= stOmitPositions, XmlUpdateRequestHandlerTest, TermVectorComponentTest, More= LikeThisHandlerTest, RequiredFieldsTest, FieldAnalysisRequestHandlerTest, L= oggingHandlerTest, RegexBoostProcessorTest, JSONWriterTest, UniqFieldsUpdat= eProcessorFactoryTest, BinaryUpdateRequestHandlerTest, TestPartialUpdateDed= uplication, CSVRequestHandlerTest, TestLFUCache, CollectionsAPISolrJTest, F= orceLeaderTest, OutOfBoxZkACLAndCredentialsProvidersTest, OverriddenZkACLAn= dCredentialsProvidersTest, OverseerCollectionConfigSetProcessorTest, Overse= erRolesTest, ReplaceNodeTest, SSLMigrationTest, ShardSplitTest, TestReplica= Properties, TestRequestStatusCollectionAPI, TestSolrCloudWithDelegationToke= ns, TestStressCloudBlindAtomicUpdates, TriLevelCompositeIdRoutingTest, Blob= RepositoryCloudTest, QueryResultKeyTest, TestConfigSets, TestDynamicLoading= , TestReqParamsAPI, TestSolrConfigHandlerConcurrent, DistributedExpandCompo= nentTest, DistributedFacetExistsSmallTest, DistributedFacetPivotSmallAdvanc= edTest, DistributedFacetPivotSmallTest, SpatialHeatmapFacetsTest, TestCloud= ManagedSchema, AnalyticsMergeStrategyTest, AnalyticsQueryTest, CursorMarkTe= st, RankQueryTest, SortSpecParsingTest, TestCollapseQParserPlugin, TestMaxS= coreQueryParser, TestQueryWrapperFilter, TestRandomCollapseQParserPlugin, T= estSortByMinMaxFunction, BJQParserTest, BlockJoinFacetDistribTest, BlockJoi= nFacetSimpleTest, GraphQueryTest, TestScoreJoinQPScore, CloudMLTQParserTest= , TestDistribIDF, BasicAuthIntegrationTest] [junit4] Completed [598/630 (1!)] on J2 in 9.67s, 1 test, 1 error <<< FA= ILURES! [...truncated 60354 lines...] ------=_Part_1338_1027452324.1473608425978 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_1338_1027452324.1473608425978--