Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/17/
2 tests failed. FAILED: org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable Error Message: Timeout while trying to assert replication errors Stack Trace: java.lang.AssertionError: Timeout while trying to assert replication errors at __randomizedtesting.SeedInfo.seed([7FFD6E506C30D409:99693423676FB921]:0) at org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable(CdcrReplicationDistributedZkTest.java:140) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:498) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871) at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907) at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996) at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367) at java.lang.Thread.run(Thread.java:745) Caused by: java.lang.AssertionError at org.junit.Assert.fail(Assert.java:92) at org.junit.Assert.assertTrue(Assert.java:43) at org.junit.Assert.assertTrue(Assert.java:54) at org.apache.solr.cloud.CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable(CdcrReplicationDistributedZkTest.java:127) ... 41 more FAILED: org.apache.solr.cloud.UnloadDistributedZkTest.test Error Message: Captured an uncaught exception in thread: Thread[id=19519, name=testExecutor-4520-thread-11, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] Stack Trace: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19519, name=testExecutor-4520-thread-11, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] at __randomizedtesting.SeedInfo.seed([7FFD6E506C30D409:F7A9518AC2CCB9F1]:0) Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43802/tz/zi at __randomizedtesting.SeedInfo.seed([7FFD6E506C30D409]:0) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$0(BasicDistributedZkTest.java:583) at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) at java.lang.Thread.run(Thread.java:745) Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43802/tz/zi at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$0(BasicDistributedZkTest.java:581) ... 4 more Caused by: java.net.SocketTimeoutException: Read timed out at java.net.SocketInputStream.socketRead0(Native Method) at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) at java.net.SocketInputStream.read(SocketInputStream.java:170) at java.net.SocketInputStream.read(SocketInputStream.java:141) at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) ... 8 more Build Log: [...truncated 11553 lines...] [junit4] Suite: org.apache.solr.cloud.CdcrReplicationDistributedZkTest [junit4] 2> Creating dataDir: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/init-core-data-001 [junit4] 2> 466247 INFO (SUITE-CdcrReplicationDistributedZkTest-seed#[7FFD6E506C30D409]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) [junit4] 2> 466247 INFO (SUITE-CdcrReplicationDistributedZkTest-seed#[7FFD6E506C30D409]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /la/ [junit4] 2> 466251 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER [junit4] 2> 466251 INFO (Thread-4879) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0 [junit4] 2> 466251 INFO (Thread-4879) [ ] o.a.s.c.ZkTestServer Starting server [junit4] 2> 466351 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkTestServer start zk server on port:38549 [junit4] 2> 466351 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 466352 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 466357 INFO (zkCallback-278-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@173ad086 name:ZooKeeperConnection Watcher:127.0.0.1:38549 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 466357 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 466358 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 466358 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /solr [junit4] 2> 466362 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 466364 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 466366 INFO (zkCallback-279-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@756f81de name:ZooKeeperConnection Watcher:127.0.0.1:38549/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 466366 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 466367 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 466367 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1 [junit4] 2> 466369 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards [junit4] 2> 466370 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection [junit4] 2> 466372 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards [junit4] 2> 466373 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-cdcr.xml to /configs/conf1/solrconfig.xml [junit4] 2> 466373 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml [junit4] 2> 466376 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema15.xml to /configs/conf1/schema.xml [junit4] 2> 466376 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml [junit4] 2> 466379 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 466379 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.snippet.randomindexconfig.xml [junit4] 2> 466381 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt [junit4] 2> 466381 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt [junit4] 2> 466382 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt [junit4] 2> 466382 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt [junit4] 2> 466384 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml [junit4] 2> 466384 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml [junit4] 2> 466386 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml [junit4] 2> 466387 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml [junit4] 2> 466388 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json [junit4] 2> 466389 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json [junit4] 2> 466390 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 466391 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt [junit4] 2> 466393 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt [junit4] 2> 466393 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt [junit4] 2> 466395 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.AbstractZkTestCase put /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt [junit4] 2> 466395 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt [junit4] 2> 466399 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testTargetCollectionNotAvailable [junit4] 2> 466520 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1 [junit4] 2> 466521 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 466523 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1edf0cbd{/la,null,AVAILABLE} [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.ServerConnector Started ServerConnector@5d75bc9d{HTTP/1.1,[http/1.1]}{127.0.0.1:35328} [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.Server Started @469690ms [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard1, hostContext=/la, hostPort=35328, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores} [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001' [junit4] 2> 466525 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 466526 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 466526 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 466526 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 466528 INFO (zkCallback-280-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5940a854 name:ZooKeeperConnection Watcher:127.0.0.1:38549/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 466528 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 466529 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 466530 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 466530 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/solr.xml [junit4] 2> 466536 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores [junit4] 2> 466537 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer New CoreContainer 1078821418 [junit4] 2> 466537 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001] [junit4] 2> 466537 WARN (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/lib [junit4] 2> 466537 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 466538 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 466539 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 466539 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 466539 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38549/solr [junit4] 2> 466539 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 466539 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 466540 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 466542 INFO (zkCallback-283-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@111beda name:ZooKeeperConnection Watcher:127.0.0.1:38549 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 466542 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 466542 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 466544 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 466546 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@67e4cca4 name:ZooKeeperConnection Watcher:127.0.0.1:38549/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 466546 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 466547 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue [junit4] 2> 466550 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-queue-work [junit4] 2> 466553 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-running [junit4] 2> 466555 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-completed [junit4] 2> 466556 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/collection-map-failure [junit4] 2> 466558 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /live_nodes [junit4] 2> 466560 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /aliases.json [junit4] 2> 466561 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json [junit4] 2> 466563 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /security.json [junit4] 2> 466564 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 466565 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 466567 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect [junit4] 2> 466569 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/election [junit4] 2> 466570 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 466570 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95581383828504580-127.0.0.1:35328_la-n_0000000000 [junit4] 2> 466571 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:35328_la [junit4] 2> 466571 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect/leader [junit4] 2> 466572 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer Overseer (id=95581383828504580-127.0.0.1:35328_la-n_0000000000) starting [junit4] 2> 466574 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work [junit4] 2> 466579 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000 autoReplicaFailoverWaitAfterExpiration=30000 autoReplicaFailoverBadNodeExpiration=60000 [junit4] 2> 466580 INFO (OverseerCollectionConfigSetProcessor-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.OverseerTaskProcessor Process current queue of overseer operations [junit4] 2> 466580 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer Starting to work on the main queue [junit4] 2> 466580 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:35328_la [junit4] 2> 466581 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:35328_la [junit4] 2> 466583 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (0) [junit4] 2> 466583 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [0]) [junit4] 2> 466583 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 466596 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 466596 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 466597 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores [junit4] 2> 466598 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=tmp_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 466598 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1 [junit4] 2> 466598 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 466599 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 466599 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 466599 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 466599 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:35328_la ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 466600 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:35328/la", [junit4] 2> "node_name":"127.0.0.1:35328_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} current state version: 0 [junit4] 2> 466600 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 466601 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:35328/la", [junit4] 2> "node_name":"127.0.0.1:35328_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} [junit4] 2> 466601 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ClusterStateMutator building a new cName: tmp_collection [junit4] 2> 466601 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard2 [junit4] 2> 466602 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 467600 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 467601 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:tmp_collection [junit4] 2> 467601 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController Creating collection in ZooKeeper:tmp_collection [junit4] 2> 467601 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController Looking for collection configName [junit4] 2> 467602 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ZkController Only one config set found in zk - using it:conf1 [junit4] 2> 467602 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection [junit4] 2> 467603 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A collections change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/collections], has occurred - updating... [junit4] 2> 467603 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/tmp_collection] [junit4] 2> 467604 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/tmp_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 467604 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1' [junit4] 2> 467604 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 467604 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 467606 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 467614 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 467617 WARN (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead. [junit4] 2> 467618 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0 [junit4] 2> 467636 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml [junit4] 2> 467642 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=test [junit4] 2> 467718 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.s.IndexSchema default search field in schema is text [junit4] 2> 467719 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.s.IndexSchema unique key field: id [junit4] 2> 467719 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 467722 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml [junit4] 2> 467740 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default properties: Can't find resource 'configsetprops.json' in classpath or '/configs/conf1', cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 467740 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from collection tmp_collection [junit4] 2> 467741 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory [junit4] 2> 467741 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1], dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/] [junit4] 2> 467741 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d304a0f [junit4] 2> 467741 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data [junit4] 2> 467742 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore New index directory detected: old=null new=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/index/ [junit4] 2> 467742 WARN (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/index' doesn't exist. Creating new index... [junit4] 2> 467742 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/index [junit4] 2> 467742 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=8, maxMergeAtOnceExplicit=5, maxMergedSegmentMB=92.9912109375, floorSegmentMB=2.1640625, forceMergeDeletesPctAllowed=26.847327271450503, segmentsPerTier=4.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0 [junit4] 2> 467743 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@6d4c6a10 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@98ba223),segFN=segments_1,generation=1} [junit4] 2> 467743 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 467743 INFO (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore Looking for old index directories to cleanup for core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/ [junit4] 2> 467743 WARN (OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.DirectoryFactory /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-001/cores/collection1/data/ does not point to a valid data directory; skipping clean-up of old index directories. [junit4] 2> 467747 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain "cdcr-processor-chain" [junit4] 2> 467762 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 467764 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 467765 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 467766 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 467767 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60 [junit4] 2> 467780 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.RequestHandlers Registered paths: /admin/mbeans,standard,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/cdcr,/update,/admin/file [junit4] 2> 467780 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore Using default statsCache cache: org.apache.solr.search.stats.LocalStatsCache [junit4] 2> 467791 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.CdcrUpdateLog [junit4] 2> 467791 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536 [junit4] 2> 467792 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled [junit4] 2> 467792 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled [junit4] 2> 467792 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=17, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.23108715385586126] [junit4] 2> 467793 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RawDirectoryWrapper(RAMDirectory@6d4c6a10 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@98ba223),segFN=segments_1,generation=1} [junit4] 2> 467793 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1 [junit4] 2> 467793 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@55eb2567[collection1] main] [junit4] 2> 467793 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/tmp_collection] [junit4] 2> 467794 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/tmp_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 467794 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based storage for the RestManager with znodeBase: /configs/conf1 [junit4] 2> 467794 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1 [junit4] 2> 467794 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {} [junit4] 2> 467794 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 467795 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode /configs/conf1/_rest_managed.json [junit4] 2> 467795 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1 [junit4] 2> 467795 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources [junit4] 2> 467795 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000 [junit4] 2> 467799 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection/cdcr/state [junit4] 2> 467802 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.CdcrBufferStateManager Created znode /collections/tmp_collection/cdcr/state/buffer [junit4] 2> 467807 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.h.CdcrProcessStateManager Created znode /collections/tmp_collection/cdcr/state/process [junit4] 2> 467824 INFO (searcherExecutor-1122-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@55eb2567[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 467824 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed version buckets [junit4] 2> 467824 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for 65536 version buckets from index [junit4] 2> 467824 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed version bucket highest value from index [junit4] 2> 467824 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1529302142904434688 [junit4] 2> 467826 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with highest version 1529302142904434688 [junit4] 2> 467826 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1 [junit4] 2> 467827 INFO (coreLoadExecutor-1121-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.CoreContainer registering core: collection1 [junit4] 2> 467827 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController Register replica - core:collection1 address:http://127.0.0.1:35328/la collection:tmp_collection shard:shard2 [junit4] 2> 467828 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection/leader_elect/shard2/election [junit4] 2> 467831 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.LeaderElector Joined leadership election with path: /collections/tmp_collection/leader_elect/shard2/election/95581383828504580-core_node1-n_0000000000 [junit4] 2> 467831 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process for shard=shard2 and weAreReplacement=false and leaderVoteWait=10000 [junit4] 2> 467833 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue. [junit4] 2> 467833 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync [junit4] 2> 467833 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"tmp_collection"} current state version: 1 [junit4] 2> 467833 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:35328/la/collection1/ [junit4] 2> 467833 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me [junit4] 2> 467833 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:35328/la/collection1/ has no replicas [junit4] 2> 467834 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.c.SolrZkClient makePath: /collections/tmp_collection/leaders/shard2 [junit4] 2> 467837 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/tmp_collection/leaders/shard2/leader after winning as /collections/tmp_collection/leader_elect/shard2/election/95581383828504580-core_node1-n_0000000000 [junit4] 2> 467837 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.h.CdcrLeaderStateManager Received new leader state @ tmp_collection:shard2 [junit4] 2> 467840 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:35328/la/collection1/ shard2 [junit4] 2> 467841 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"leader", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"tmp_collection", [junit4] 2> "base_url":"http://127.0.0.1:35328/la", [junit4] 2> "core":"collection1", [junit4] 2> "state":"active"} current state version: 1 [junit4] 2> 467943 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 467992 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController We are http://127.0.0.1:35328/la/collection1/ and leader is http://127.0.0.1:35328/la/collection1/ [junit4] 2> 467992 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:35328/la [junit4] 2> 467992 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary [junit4] 2> 467992 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController publishing state=active [junit4] 2> 467992 INFO (coreZkRegister-1115-thread-1-processing-n:127.0.0.1:35328_la x:collection1 s:shard2 c:tmp_collection r:core_node1) [n:127.0.0.1:35328_la c:tmp_collection s:shard2 r:core_node1 x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 467995 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:35328/la", [junit4] 2> "node_name":"127.0.0.1:35328_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} current state version: 2 [junit4] 2> 467995 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "core_node_name":"core_node1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:35328/la", [junit4] 2> "node_name":"127.0.0.1:35328_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"active", [junit4] 2> "shard":"shard2", [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} [junit4] 2> 468099 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 468201 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores/collection1 [junit4] 2> 468209 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.Server jetty-9.3.8.v20160314 [junit4] 2> 468211 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@7886f16b{/la,null,AVAILABLE} [junit4] 2> 468213 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.ServerConnector Started ServerConnector@549b61b8{HTTP/1.1,[http/1.1]}{127.0.0.1:41326} [junit4] 2> 468214 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.e.j.s.Server Started @471378ms [junit4] 2> 468214 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {shards=shard2, hostContext=/la, hostPort=41326, coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores} [junit4] 2> 468216 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init(): sun.misc.Launcher$AppClassLoader@73d16e93 [junit4] 2> 468216 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002' [junit4] 2> 468216 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 468216 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 468216 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 468218 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 468220 INFO (zkCallback-285-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@5a9899cf name:ZooKeeperConnection Watcher:127.0.0.1:38549/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 468220 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 468220 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 468222 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper) [junit4] 2> 468222 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/solr.xml [junit4] 2> 468232 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores [junit4] 2> 468233 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer New CoreContainer 715281637 [junit4] 2> 468233 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer Loading cores into CoreContainer [instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002] [junit4] 2> 468233 WARN (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.CoreContainer Couldn't add files from /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/lib to classpath: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/lib [junit4] 2> 468233 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme : ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections : 10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime : 5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false, [junit4] 2> 468234 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params: socketTimeout=340000&connTimeout=45000&retry=true [junit4] 2> 468235 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 468235 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 468235 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:38549/solr [junit4] 2> 468235 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.ZkController zkHost includes chroot [junit4] 2> 468235 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider [junit4] 2> 468236 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 468237 INFO (zkCallback-288-thread-1) [ ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@1c2d71b5 name:ZooKeeperConnection Watcher:127.0.0.1:38549 got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 468238 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 468238 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider [junit4] 2> 468245 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper [junit4] 2> 468246 INFO (zkCallback-289-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la ] o.a.s.c.c.ConnectionManager Watcher org.apache.solr.common.cloud.ConnectionManager@74decb37 name:ZooKeeperConnection Watcher:127.0.0.1:38549/solr got event WatchedEvent state:SyncConnected type:None path:null path:null type:None [junit4] 2> 468249 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper [junit4] 2> 468256 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper... [junit4] 2> 468257 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1) [junit4] 2> 468259 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.Overseer Overseer (id=null) closing [junit4] 2> 468260 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.LeaderElector Joined leadership election with path: /overseer_elect/election/95581383828504583-127.0.0.1:41326_la-n_0000000001 [junit4] 2> 468261 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.LeaderElector Watching path /overseer_elect/election/95581383828504580-127.0.0.1:35328_la-n_0000000000 to know if I could be the leader [junit4] 2> 468261 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.ZkController Publish node=127.0.0.1:41326_la as DOWN [junit4] 2> 468263 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "operation":"downnode", [junit4] 2> "node_name":"127.0.0.1:41326_la"} current state version: 3 [junit4] 2> 468263 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.NodeMutator DownNode state invoked for node: 127.0.0.1:41326_la [junit4] 2> 468365 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 468365 INFO (zkCallback-289-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [1]) [junit4] 2> 469264 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41326_la [junit4] 2> 469264 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.c.SolrZkClient makePath: /live_nodes/127.0.0.1:41326_la [junit4] 2> 469265 INFO (zkCallback-289-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 469265 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live nodes size: [1]) [junit4] 2> 469278 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 469278 INFO (zkCallback-289-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2) [junit4] 2> 469281 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CoreContainer Security conf doesn't exist. Skipping setup for authorization module. [junit4] 2> 469281 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CoreContainer No authentication plugin used. [junit4] 2> 469281 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CorePropertiesLocator Looking for core definitions underneath /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores [junit4] 2> 469282 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CoreDescriptor Created CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json, collection=tmp_collection, coreNodeName=, dataDir=data/, shard=} [junit4] 2> 469282 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CorePropertiesLocator Found core collection1 in /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores/collection1 [junit4] 2> 469283 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.c.CorePropertiesLocator Found 1 core definitions [junit4] 2> 469291 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController publishing state=down [junit4] 2> 469291 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading it from system property [junit4] 2> 469291 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.s.SolrDispatchFilter user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0 [junit4] 2> 469291 INFO (TEST-CdcrReplicationDistributedZkTest.testTargetCollectionNotAvailable-seed#[7FFD6E506C30D409]) [n:127.0.0.1:41326_la ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init() done [junit4] 2> 469292 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController Registering watch for collection tmp_collection [junit4] 2> 469292 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader addZkWatch [tmp_collection] [junit4] 2> 469292 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader Deleting data for [tmp_collection] [junit4] 2> 469292 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.Overseer processMessage: queueSize: 1, message = { [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41326/la", [junit4] 2> "node_name":"127.0.0.1:41326_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} current state version: 4 [junit4] 2> 469293 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Update state numShards=2 message={ [junit4] 2> "core":"collection1", [junit4] 2> "roles":null, [junit4] 2> "base_url":"http://127.0.0.1:41326/la", [junit4] 2> "node_name":"127.0.0.1:41326_la", [junit4] 2> "numShards":"2", [junit4] 2> "state":"down", [junit4] 2> "shard":null, [junit4] 2> "collection":"tmp_collection", [junit4] 2> "operation":"state"} [junit4] 2> 469293 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Collection already exists with numShards=2 [junit4] 2> 469293 INFO (OverseerStateUpdate-95581383828504580-127.0.0.1:35328_la-n_0000000000) [n:127.0.0.1:35328_la ] o.a.s.c.o.ReplicaMutator Assigning new node to shard shard=shard1 [junit4] 2> 469294 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController look for our core node name [junit4] 2> 469395 INFO (zkCallback-289-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [2]) [junit4] 2> 469395 INFO (zkCallback-284-thread-1-processing-n:127.0.0.1:35328_la) [n:127.0.0.1:35328_la ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json], has occurred - updating... (live nodes size: [2]) [junit4] 2> 470294 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1 [junit4] 2> 470294 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController Check for collection zkNode:tmp_collection [junit4] 2> 470294 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.ZkController Collection zkNode exists [junit4] 2> 470294 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader Load collection config from: [/collections/tmp_collection] [junit4] 2> 470295 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/tmp_collection] [configName]=[conf1] specified config exists in ZooKeeper [junit4] 2> 470295 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory: '/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J0/temp/solr.cloud.CdcrReplicationDistributedZkTest_7FFD6E506C30D409-001/jetty-002/cores/collection1' [junit4] 2> 470295 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 470295 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find system property or JNDI) [junit4] 2> 470297 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.Config loaded config solrconfig.xml with version 0 [junit4] 2> 470302 INFO (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.SolrConfig current version of requestparams : -1 [junit4] 2> 470324 WARN (coreLoadExecutor-1133-thread-1-processing-n:127.0.0.1:41326_la) [n:127.0.0.1:41326_la c:tmp_collection x:collection1] o.a.s.c.Config Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> ins [...truncated too long message...] E: download the large Jenkins line-docs file by running 'ant get-jenkins-line-docs' in the lucene directory. [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=UnloadDistributedZkTest -Dtests.method=test -Dtests.seed=7FFD6E506C30D409 -Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true -Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt -Dtests.locale=fr-CH -Dtests.timezone=Pacific/Majuro -Dtests.asserts=true -Dtests.file.encoding=US-ASCII [junit4] ERROR 138s J2 | UnloadDistributedZkTest.test <<< [junit4] > Throwable #1: com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught exception in thread: Thread[id=19519, name=testExecutor-4520-thread-11, state=RUNNABLE, group=TGRP-UnloadDistributedZkTest] [junit4] > at __randomizedtesting.SeedInfo.seed([7FFD6E506C30D409:F7A9518AC2CCB9F1]:0) [junit4] > Caused by: java.lang.RuntimeException: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43802/tz/zi [junit4] > at __randomizedtesting.SeedInfo.seed([7FFD6E506C30D409]:0) [junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$0(BasicDistributedZkTest.java:583) [junit4] > at org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229) [junit4] > at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] > at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] > Caused by: org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting response from server at: http://127.0.0.1:43802/tz/zi [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230) [junit4] > at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219) [junit4] > at org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$0(BasicDistributedZkTest.java:581) [junit4] > ... 4 more [junit4] > Caused by: java.net.SocketTimeoutException: Read timed out [junit4] > at java.net.SocketInputStream.socketRead0(Native Method) [junit4] > at java.net.SocketInputStream.socketRead(SocketInputStream.java:116) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:170) [junit4] > at java.net.SocketInputStream.read(SocketInputStream.java:141) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160) [junit4] > at org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84) [junit4] > at org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140) [junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57) [junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261) [junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283) [junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251) [junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272) [junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685) [junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487) [junit4] > at org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107) [junit4] > at org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55) [junit4] > at org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482) [junit4] > ... 8 more [junit4] 2> 1596724 INFO (SUITE-UnloadDistributedZkTest-seed#[7FFD6E506C30D409]-worker) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore [junit4] 2> Mar 20, 2016 7:01:44 AM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks [junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s). [junit4] 2> NOTE: test params are: codec=Asserting(Lucene60): {other_tl1=BlockTreeOrds(blocksize=128), range_facet_l_dv=PostingsFormat(name=Asserting), _version_=BlockTreeOrds(blocksize=128), multiDefault=PostingsFormat(name=LuceneVarGapFixedInterval), a_t=BlockTreeOrds(blocksize=128), intDefault=BlockTreeOrds(blocksize=128), a_i1=BlockTreeOrds(blocksize=128), id=PostingsFormat(name=Asserting), range_facet_i_dv=BlockTreeOrds(blocksize=128), text=PostingsFormat(name=LuceneVarGapDocFreqInterval), range_facet_l=BlockTreeOrds(blocksize=128), timestamp=BlockTreeOrds(blocksize=128)}, docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54), range_facet_i_dv=DocValuesFormat(name=Asserting), timestamp=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1994, maxMBSortInHeap=5.969688430660409, sim=RandomSimilarity(queryNorm=true,coord=no): {}, locale=fr-CH, timezone=Pacific/Majuro [junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation 1.8.0_74 (64-bit)/cpus=4,threads=1,free=226887016,total=520093696 [junit4] 2> NOTE: All tests run in this JVM: [TestWriterPerf, TestCSVResponseWriter, RulesTest, HdfsRestartWhileUpdatingTest, HighlighterConfigTest, TestRandomCollapseQParserPlugin, SpatialRPTFieldTypeTest, ClassificationUpdateProcessorFactoryTest, TestSolrQueryResponse, CleanupOldIndexTest, TestReloadAndDeleteDocs, TestJsonRequest, TestRecovery, CurrencyFieldXmlFileTest, MultiThreadedOCPTest, BadComponentTest, TestSolrQueryParser, HdfsChaosMonkeyNothingIsSafeTest, BlockJoinFacetDistribTest, TestDefaultStatsCache, HdfsDirectoryTest, TestSolrJ, CircularListTest, VersionInfoTest, TestConfigOverlay, DateRangeFieldTest, SimpleFacetsTest, TestUseDocValuesAsStored2, HighlighterMaxOffsetTest, TestCoreDiscovery, TestPivotHelperCode, TestIndexSearcher, TestIndexingPerformance, TestCloudDeleteByQuery, TestPerFieldSimilarity, TestPerFieldSimilarityClassic, OverseerTaskQueueTest, HdfsNNFailoverTest, TestExactStatsCache, TestDocBasedVersionConstraints, TestStressReorder, TestSchemaNameResource, TestObjectReleaseTracker, SharedFSAutoReplicaFailoverTest, CollectionStateFormat2Test, TestSuggestSpellingConverter, TestDynamicFieldCollectionResource, TestSolrDynamicMBean, TestReload, TestReversedWildcardFilterFactory, PrimitiveFieldTypeTest, TestRuleBasedAuthorizationPlugin, DistributedExpandComponentTest, DeleteLastCustomShardedReplicaTest, QueryParsingTest, TermVectorComponentDistributedTest, DebugComponentTest, TestSimpleQParserPlugin, GraphQueryTest, ScriptEngineTest, TestCollapseQParserPlugin, SolrTestCaseJ4Test, ClusterStateTest, TestMacros, TestJmxIntegration, ReplicationFactorTest, StatelessScriptUpdateProcessorFactoryTest, ConjunctionSolrSpellCheckerTest, AnalysisErrorHandlingTest, FacetPivotSmallTest, NoCacheHeaderTest, TestExtendedDismaxParser, BlockCacheTest, TestNamedUpdateProcessors, TestDownShardTolerantSearch, RegexBoostProcessorTest, RecoveryZkTest, RequestHandlersTest, TestConfigSetsAPIZkFailure, TestJettySolrRunner, TestRequestStatusCollectionAPI, LeaderInitiatedRecoveryOnCommitTest, SolrCoreCheckLockOnStartupTest, LeaderElectionTest, TestManagedResourceStorage, DirectSolrConnectionTest, TestCharFilters, TestZkChroot, TestInitQParser, OverseerTest, TestFileDictionaryLookup, TestSweetSpotSimilarityFactory, BasicDistributedZk2Test, UnloadDistributedZkTest] [junit4] Completed [200/581 (2!)] on J2 in 138.59s, 1 test, 1 error <<< FAILURES! [...truncated 1216 lines...] BUILD FAILED /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457: The following error occurred while executing this line: /x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014: There were test failures: 581 suites (10 ignored), 2327 tests, 1 error, 1 failure, 32 ignored (16 assumptions) [seed: 7FFD6E506C30D409] Total time: 203 minutes 28 seconds Build step 'Invoke Ant' marked build as failure Archiving artifacts No prior successful build to compare, so performing full copy of artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org