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: [email protected]
For additional commands, e-mail: [email protected]