Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/950/
3 tests failed.
FAILED: org.apache.solr.cloud.CollectionTooManyReplicasTest.testDownedShards
Error Message:
Should have gotten a message about shard not
Stack Trace:
java.lang.AssertionError: Should have gotten a message about shard not
at
__randomizedtesting.SeedInfo.seed([F48E00C5EEA70AA8:96A6A890655C47EC]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.cloud.CollectionTooManyReplicasTest.testDownedShards(CollectionTooManyReplicasTest.java:256)
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:497)
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)
FAILED: org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=124750,
name=testExecutor-7249-thread-7, state=RUNNABLE,
group=TGRP-HdfsUnloadDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=124750, name=testExecutor-7249-thread-7,
state=RUNNABLE, group=TGRP-HdfsUnloadDistributedZkTest]
Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:33407
at __randomizedtesting.SeedInfo.seed([F48E00C5EEA70AA8]:0)
at
org.apache.solr.cloud.BasicDistributedZkTest.lambda$createCores$3(BasicDistributedZkTest.java:583)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$6(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:33407
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$3(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
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
timed out waiting for collection1 startAt time to exceed: Sat Mar 05 12:32:19
ACDT 2016
Stack Trace:
java.lang.AssertionError: timed out waiting for collection1 startAt time to
exceed: Sat Mar 05 12:32:19 ACDT 2016
at
__randomizedtesting.SeedInfo.seed([F48E00C5EEA70AA8:2F250003EB8F631B]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.handler.TestReplicationHandler.watchCoreStartAt(TestReplicationHandler.java:1422)
at
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:774)
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:497)
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
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)
Build Log:
[...truncated 11451 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionTooManyReplicasTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/init-core-data-001
[junit4] 2> 959871 INFO
(SUITE-CollectionTooManyReplicasTest-seed#[F48E00C5EEA70AA8]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 959871 INFO
(SUITE-CollectionTooManyReplicasTest-seed#[F48E00C5EEA70AA8]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /aqc/q
[junit4] 2> 959881 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 959882 INFO (Thread-1905) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 959882 INFO (Thread-1905) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 959982 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkTestServer start zk server on port:53184
[junit4] 2> 959982 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 959983 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 959986 INFO (zkCallback-1857-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4a174a9 name:ZooKeeperConnection
Watcher:127.0.0.1:53184 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 959986 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 959986 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 959986 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 959990 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 959991 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 959992 INFO (zkCallback-1858-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@49d4dd03
name:ZooKeeperConnection Watcher:127.0.0.1:53184/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 959992 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 959992 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 959992 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 959994 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 959995 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 959997 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 959998 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 959999 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 960001 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 960001 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 960003 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 960003 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 960005 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 960005 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 960006 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 960007 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 960008 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 960008 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 960010 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 960010 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 960012 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 960012 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 960013 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 960014 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 960015 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 960015 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 960017 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 960017 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 960019 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x153446872490001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 960118 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1
[junit4] 2> 960120 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 960122 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3cdc8a46{/aqc/q,null,AVAILABLE}
[junit4] 2> 960124 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.ServerConnector Started
ServerConnector@720c6faf{HTTP/1.1,[http/1.1]}{127.0.0.1:36460}
[junit4] 2> 960124 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.Server Started @963153ms
[junit4] 2> 960124 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/tempDir-001/control/data,
hostContext=/aqc/q, hostPort=36460,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores}
[junit4] 2> 960124 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 960125 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001'
[junit4] 2> 960125 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 960125 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 960125 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 960130 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 960131 INFO (zkCallback-1859-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@51919370
name:ZooKeeperConnection Watcher:127.0.0.1:53184/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 960131 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 960132 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 960133 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 960133 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/solr.xml
[junit4] 2> 960138 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores
[junit4] 2> 960138 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer New CoreContainer 305337236
[junit4] 2> 960138 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001]
[junit4] 2> 960139 WARN
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/lib
[junit4] 2> 960139 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] 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> 960140 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 960140 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 960140 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 960141 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53184/solr
[junit4] 2> 960141 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 960141 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 960141 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 960145 INFO (zkCallback-1862-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5e817cb7
name:ZooKeeperConnection Watcher:127.0.0.1:53184 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 960145 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 960146 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 960148 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 960148 INFO
(zkCallback-1863-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5ef0e393
name:ZooKeeperConnection Watcher:127.0.0.1:53184/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 960149 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 960150 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 960151 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 960154 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 960155 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 960157 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 960158 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 960160 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 960161 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 960162 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 960162 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 960163 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 960165 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 960166 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 960166 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 960167 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.LeaderElector Joined leadership
election with path:
/overseer_elect/election/95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000
[junit4] 2> 960167 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:36460_aqc%2Fq
[junit4] 2> 960168 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 960169 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer Overseer
(id=95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000) starting
[junit4] 2> 960171 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 960176 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 960176 INFO
(OverseerCollectionConfigSetProcessor-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.OverseerTaskProcessor Process current
queue of overseer operations
[junit4] 2> 960176 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 960177 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:36460_aqc%2Fq
[junit4] 2> 960178 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:36460_aqc%2Fq
[junit4] 2> 960178 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 960179 INFO
(zkCallback-1863-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] 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> 960181 INFO
(zkCallback-1863-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 960198 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 960198 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 960198 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores
[junit4] 2> 960199 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CoreDescriptor Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true, configSetProperties=configsetprops.json,
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 960199 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CorePropertiesLocator Found core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1
[junit4] 2> 960199 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 960200 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0
[junit4] 2> 960200 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 960200 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 960200 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 960202 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] 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:36460/aqc/q";,
[junit4] 2> "node_name":"127.0.0.1:36460_aqc%2Fq",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 960202 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 960202 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:36460/aqc/q";,
[junit4] 2> "node_name":"127.0.0.1:36460_aqc%2Fq",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 960203 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 960203 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 960205 INFO
(zkCallback-1863-thread-2-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] 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> 961203 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 961203 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 961203 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 961203 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 961204 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 961204 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1'
[junit4] 2> 961204 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 961204 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 961206 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 961211 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 961216 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 961243 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 961249 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 961346 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 961353 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 961354 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 961366 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 961369 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 961371 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 961372 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 961374 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_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-master/solr/build/solr-core/test/J0
[junit4] 2> 961374 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 961375 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 961375 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/]
[junit4] 2> 961375 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 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@314293c8
[junit4] 2> 961376 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data
[junit4] 2> 961376 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 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-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/index/
[junit4] 2> 961376 WARN
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 961376 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/index
[junit4] 2> 961376 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@435da981
[junit4] 2> 961377 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f75ad2
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60dccfdc),segFN=segments_1,generation=1}
[junit4] 2> 961377 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 961377 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:36460_aqc%2Fq
c:control_collection s:shard1 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-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/
[junit4] 2> 961379 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:36460_aqc%2Fq
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 961382 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 961392 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 961392 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 961392 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 961392 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 961392 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 961393 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 961393 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 961393 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 961393 WARN
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 961395 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 961396 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 961397 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 961398 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 961404 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/dump,/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,/update,/admin/file
[junit4] 2> 961405 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 961405 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 961406 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 961406 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 961406 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 961407 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=15, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=75.9453125,
floorSegmentMB=0.9921875, forceMergeDeletesPctAllowed=28.670696687759545,
segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 961407 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@11f75ad2
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@60dccfdc),segFN=segments_1,generation=1}
[junit4] 2> 961407 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 961407 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@90e1d85[collection1]
main]
[junit4] 2> 961408 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 961409 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 961409 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 961409 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 961409 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 961409 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 961410 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 961410 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 961410 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 961410 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 961411 INFO
(searcherExecutor-2315-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@90e1d85[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 961411 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed
version buckets
[junit4] 2> 961411 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for
65536 version buckets from index
[junit4] 2> 961411 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 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> 961411 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1527923721433513984
[junit4] 2> 961413 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 2.0ms to seed version buckets with
highest version 1527923721433513984
[junit4] 2> 961413 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 961414 INFO
(coreLoadExecutor-2314-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 961415 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController Register replica - core:collection1
address:http://127.0.0.1:36460/aqc/q collection:control_collection shard:shard1
[junit4] 2> 961415 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 961418 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.LeaderElector Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/95495232489586692-core_node1-n_0000000000
[junit4] 2> 961419 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process
for shard=shard1 and weAreReplacement=false and leaderVoteWait=10000
[junit4] 2> 961420 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 961420 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 961420 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:36460/aqc/q/collection1/
[junit4] 2> 961420 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 961420 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:36460/aqc/q/collection1/
has no replicas
[junit4] 2> 961420 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 961421 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 961423 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader
registration node /collections/control_collection/leaders/shard1/leader after
winning as
/collections/control_collection/leader_elect/shard1/election/95495232489586692-core_node1-n_0000000000
[junit4] 2> 961426 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:36460/aqc/q/collection1/ shard1
[junit4] 2> 961426 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:36460/aqc/q";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 1
[junit4] 2> 961529 INFO
(zkCallback-1863-thread-2-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] 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> 961577 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController We are
http://127.0.0.1:36460/aqc/q/collection1/ and leader is
http://127.0.0.1:36460/aqc/q/collection1/
[junit4] 2> 961578 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController No LogReplay needed for core=collection1
baseURL=http://127.0.0.1:36460/aqc/q
[junit4] 2> 961578 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 961578 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController publishing state=active
[junit4] 2> 961578 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController numShards not found on descriptor - reading
it from system property
[junit4] 2> 961580 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] 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:36460/aqc/q";,
[junit4] 2> "node_name":"127.0.0.1:36460_aqc%2Fq",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 2
[junit4] 2> 961580 INFO
(coreZkRegister-2308-thread-1-processing-n:127.0.0.1:36460_aqc%2Fq
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:36460_aqc%2Fq c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1)
-> (1)
[junit4] 2> 961580 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ReplicaMutator Update state
numShards=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:36460/aqc/q";,
[junit4] 2> "node_name":"127.0.0.1:36460_aqc%2Fq",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 961683 INFO
(zkCallback-1863-thread-2-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] 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> 961703 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 961703 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 961705 INFO (zkCallback-1865-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5383cb6 name:ZooKeeperConnection
Watcher:127.0.0.1:53184/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 961705 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 961705 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 961705 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 961707 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 961708 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 961708 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 961708 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 961708 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 961709 INFO (zkCallback-1866-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@289c543f
name:ZooKeeperConnection Watcher:127.0.0.1:53184/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 961709 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 961710 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 961712 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"1",
[junit4] 2> "stateFormat":"2"} current state version: 3
[junit4] 2> 961712 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ClusterStateMutator building a new
cName: collection1
[junit4] 2> 961801 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/cores/collection1
[junit4] 2> 961802 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001
[junit4] 2> 961803 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.Server jetty-9.3.6.v20151106
[junit4] 2> 961804 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6eba4988{/aqc/q,null,AVAILABLE}
[junit4] 2> 961805 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.ServerConnector Started
ServerConnector@4a50f6{HTTP/1.1,[http/1.1]}{127.0.0.1:52806}
[junit4] 2> 961809 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.e.j.s.Server Started @964839ms
[junit4] 2> 961810 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/aqc/q, hostPort=52806,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/cores}
[junit4] 2> 961810 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@4e0e2f2a
[junit4] 2> 961810 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001'
[junit4] 2> 961810 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 961810 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 961811 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 961811 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 961812 INFO (zkCallback-1867-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@8c578f name:ZooKeeperConnection
Watcher:127.0.0.1:53184/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 961812 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 961812 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 961813 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 961813 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/solr.xml
[junit4] 2> 961814 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ZkStateWriter going to
create_collection /collections/collection1/state.json
[junit4] 2> 961818 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/cores
[junit4] 2> 961819 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer New CoreContainer 1872232600
[junit4] 2> 961819 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001]
[junit4] 2> 961819 WARN
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build/solr-core/test/J0/temp/solr.cloud.CollectionTooManyReplicasTest_F48E00C5EEA70AA8-001/shard-1-001/lib
[junit4] 2> 961819 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] 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> 961820 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:53184/solr
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 961821 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 961822 INFO (zkCallback-1870-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4c7cf164
name:ZooKeeperConnection Watcher:127.0.0.1:53184 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 961823 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 961823 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8]) [
] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 961825 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 961826 INFO
(zkCallback-1871-thread-1-processing-n:127.0.0.1:52806_aqc%2Fq)
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@7259ecf1
name:ZooKeeperConnection Watcher:127.0.0.1:53184/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 961826 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 961831 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 961832 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 961834 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 961837 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.LeaderElector Joined leadership
election with path:
/overseer_elect/election/95495232489586697-127.0.0.1:52806_aqc%2Fq-n_0000000001
[junit4] 2> 961840 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.LeaderElector Watching path
/overseer_elect/election/95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000
to know if I could be the leader
[junit4] 2> 961840 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.ZkController Publish
node=127.0.0.1:52806_aqc%2Fq as DOWN
[junit4] 2> 961842 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"downnode",
[junit4] 2> "node_name":"127.0.0.1:52806_aqc%2Fq"} current state
version: 3
[junit4] 2> 961842 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.NodeMutator DownNode state invoked
for node: 127.0.0.1:52806_aqc%2Fq
[junit4] 2> 961843 INFO
(OverseerStateUpdate-95495232489586692-127.0.0.1:36460_aqc%2Fq-n_0000000000)
[n:127.0.0.1:36460_aqc%2Fq ] o.a.s.c.o.ZkStateWriter going to
update_collection /collections/collection1/state.json version: 0
[junit4] 2> 961946 INFO (zkCallback-1865-thread-1) [ ]
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> 961946 INFO
(zkCallback-1863-thread-2-processing-n:127.0.0.1:36460_aqc%2Fq)
[n:127.0.0.1:36460_aqc%2Fq ] 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> 961946 INFO
(zkCallback-1871-thread-1-processing-n:127.0.0.1:52806_aqc%2Fq)
[n:127.0.0.1:52806_aqc%2Fq ] 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> 962842 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52806_aqc%2Fq
[junit4] 2> 962843 INFO
(TEST-CollectionTooManyReplicasTest.testAddShard-seed#[F48E00C5EEA70AA8])
[n:127.0.0.1:52806_aqc%2Fq ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:52806_aqc%2Fq
[junit4] 2> 962844 INFO (zkCallback-1865-thread-1) [ ]
o.a.s.c.c.ZkStateReader A live node
[...truncated too long message...]
.java:227)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:212)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:461)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:212)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:592)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:145)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:822)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1720)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1699)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:198)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsUnloadDistributedZkTest.teardownClass(HdfsUnloadDistributedZkTest.java:46)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:198)
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3291)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:6223)
[junit4] 2> ... 54 more
[junit4] 2> 4237960 INFO
(SUITE-HdfsUnloadDistributedZkTest-seed#[F48E00C5EEA70AA8]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> Mar 05, 2016 2:28:07 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 2 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60):
{other_tl1=PostingsFormat(name=LuceneVarGapDocFreqInterval),
range_facet_l_dv=PostingsFormat(name=Memory doPackFST= false),
_version_=PostingsFormat(name=LuceneVarGapDocFreqInterval),
multiDefault=FSTOrd50, a_t=FSTOrd50,
intDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval), a_i1=FSTOrd50,
id=PostingsFormat(name=Memory doPackFST= false), range_facet_i_dv=FSTOrd50,
text=PostingsFormat(name=LuceneFixedGap), range_facet_l=FSTOrd50,
timestamp=FSTOrd50},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54),
range_facet_i_dv=DocValuesFormat(name=Lucene54),
timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=751,
maxMBSortInHeap=5.028706227464346, sim=ClassicSimilarity, locale=bg,
timezone=Asia/Ulaanbaatar
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_66 (64-bit)/cpus=4,threads=2,free=186952712,total=520093696
[junit4] 2> NOTE: All tests run in this JVM: [TestRemoteStreaming,
ExplicitHLLTest, ConjunctionSolrSpellCheckerTest, TestLuceneMatchVersion,
CdcrReplicationDistributedZkTest, TestMergePolicyConfig,
CloneFieldUpdateProcessorFactoryTest, TestFunctionQuery,
TestSchemaSimilarityResource, ResponseLogComponentTest,
ParsingFieldUpdateProcessorsTest, InfoHandlerTest,
CollectionTooManyReplicasTest, TestScoreJoinQPScore, TestDocSet,
SimpleCollectionCreateDeleteTest, TestDefaultStatsCache, TestFieldResource,
RemoteQueryErrorTest, CurrencyFieldOpenExchangeTest, ResourceLoaderTest,
TestCollationFieldDocValues, TestNonDefinedSimilarityFactory,
RAMDirectoryFactoryTest, SolrRequestParserTest, RankQueryTest,
DistributedSpellCheckComponentTest, PathHierarchyTokenizerFactoryTest,
TestIBSimilarityFactory, TestBinaryField, CheckHdfsIndexTest,
TestRandomFaceting, TestRealTimeGet, TestFileDictionaryLookup,
SynonymTokenizerTest, LeaderFailoverAfterPartitionTest,
TestManagedResourceStorage, ZkStateReaderTest, TestCrossCoreJoin,
CoreAdminCreateDiscoverTest, QueryEqualityTest, ConfigSetsAPITest,
EnumFieldTest, CacheHeaderTest, JsonLoaderTest, XsltUpdateRequestHandlerTest,
OverriddenZkACLAndCredentialsProvidersTest, DocumentAnalysisRequestHandlerTest,
TestJoin, ActionThrottleTest, HdfsCollectionsAPIDistributedZkTest,
TestManagedStopFilterFactory, AlternateDirectoryTest,
CdcrVersionReplicationTest, TestArbitraryIndexDir, DeleteInactiveReplicaTest,
BJQParserTest, TestTrieFacet, TestFaceting, QueryResultKeyTest, RuleEngineTest,
AnalysisErrorHandlingTest, DistribDocExpirationUpdateProcessorTest,
CopyFieldTest, AnalysisAfterCoreReloadTest, TestSolr4Spatial2,
TestQueryWrapperFilter, TestHashQParserPlugin, RollingRestartTest,
TestFastOutputStream, StandardRequestHandlerTest, PingRequestHandlerTest,
TestAnalyzedSuggestions, DefaultValueUpdateProcessorTest, AnalyticsQueryTest,
RequestLoggingTest, JavabinLoaderTest, CursorPagingTest, TestNRTOpen,
DateFieldTest, HdfsThreadLeakTest, UUIDFieldTest, TestComponentsName,
VersionInfoTest, TestStressLucene, AsyncCallRequestStatusResponseTest,
TestClassNameShortening, TestHighlightDedupGrouping,
TestAtomicUpdateErrorCases, TestImplicitCoreProperties,
TestDocBasedVersionConstraints, HdfsWriteToMultipleCollectionsTest,
HdfsBasicDistributedZkTest, SignatureUpdateProcessorFactoryTest,
FileBasedSpellCheckerTest, TestRandomDVFaceting, ShardRoutingCustomTest,
TestDistributedSearch, PreAnalyzedFieldTest, PrimUtilsTest,
TestSuggestSpellingConverter, SpellingQueryConverterTest, TestSolrJ,
TestLRUCache, TestUtils, ZkNodePropsTest, SliceStateTest,
SystemInfoHandlerTest, TestRTGBase, DistributedIntervalFacetingTest,
CdcrRequestHandlerTest, DistribJoinFromCollectionTest, HttpPartitionTest,
OverseerStatusTest, ShardSplitTest, TestRequestForwarding,
TestRequestStatusCollectionAPI, TestSizeLimitedDistributedMap,
HdfsRecoverLeaseTest, HdfsRecoveryZkTest, HdfsUnloadDistributedZkTest]
[junit4] Completed [485/581 (3!)] on J0 in 152.71s, 1 test, 1 error <<<
FAILURES!
[...truncated 320 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/solr/common-build.xml:524:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/lucene/common-build.xml:1014:
There were test failures: 581 suites (8 ignored), 2344 tests, 1 error, 2
failures, 33 ignored (17 assumptions) [seed: F48E00C5EEA70AA8]
Total time: 217 minutes 39 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]
