Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.0/6/
5 tests failed.
FAILED:
org.apache.solr.cloud.CollectionsAPIAsyncDistributedZkTest.testAsyncRequests
Error Message:
Could not find a healthy node to handle the request.
Stack Trace:
org.apache.solr.common.SolrException: Could not find a healthy node to handle
the request.
at
__randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4:A21577E5E9AAC7B]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1094)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:953)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:953)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:953)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:953)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:953)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:149)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:106)
at org.apache.solr.client.solrj.SolrClient.add(SolrClient.java:71)
at
org.apache.solr.cloud.CollectionsAPIAsyncDistributedZkTest.testAsyncRequests(CollectionsAPIAsyncDistributedZkTest.java:119)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4:30EF05B4C3908057]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:174)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:135)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:130)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:850)
at
org.apache.solr.cloud.LeaderInitiatedRecoveryOnShardRestartTest.testRestartWithAllInLIR(LeaderInitiatedRecoveryOnShardRestartTest.java:158)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
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.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=34451, name=collection3,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=34451, name=collection3, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4:6631541356CE8F5C]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:37333/_jl: collection already exists:
awholynewstresscollection_collection3_0
at __randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
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.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:973)
FAILED:
junit.framework.TestSuite.org.apache.solr.handler.TestReplicationHandler
Error Message:
ObjectTracker found 8 object(s) that were not released!!! [NRTCachingDirectory,
NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory,
NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory,
NRTCachingDirectory]
Stack Trace:
java.lang.AssertionError: ObjectTracker found 8 object(s) that were not
released!!! [NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory,
NRTCachingDirectory, NRTCachingDirectory, NRTCachingDirectory,
NRTCachingDirectory, NRTCachingDirectory]
at __randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:248)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
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.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=17870, name=collection4,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=17870, name=collection4, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by: java.lang.RuntimeException:
org.apache.solr.client.solrj.SolrServerException: No live SolrServers available
to handle this request:[http://127.0.0.1:59405/sjz/xk,
http://127.0.0.1:36147/sjz/xk, http://127.0.0.1:49679/sjz/xk,
http://127.0.0.1:34909/sjz/xk, http://127.0.0.1:41771/sjz/xk]
at __randomizedtesting.SeedInfo.seed([EE656BC9F832E2A4]:0)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:983)
Caused by: org.apache.solr.client.solrj.SolrServerException: No live
SolrServers available to handle this request:[http://127.0.0.1:59405/sjz/xk,
http://127.0.0.1:36147/sjz/xk, http://127.0.0.1:49679/sjz/xk,
http://127.0.0.1:34909/sjz/xk, http://127.0.0.1:41771/sjz/xk]
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:352)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:973)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:36147/sjz/xk: KeeperErrorCode = Session expired
for /overseer/collection-queue-work/qnr-
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
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.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
... 7 more
Build Log:
[...truncated 11394 lines...]
[junit4] Suite: org.apache.solr.cloud.CollectionsAPIAsyncDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/init-core-data-001
[junit4] 2> 574466 INFO
(SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[EE656BC9F832E2A4]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true)
[junit4] 2> 574466 INFO
(SUITE-CollectionsAPIAsyncDistributedZkTest-seed#[EE656BC9F832E2A4]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 574486 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 574486 INFO (Thread-1915) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 574486 INFO (Thread-1915) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 574590 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.ZkTestServer start zk server on port:51151
[junit4] 2> 574590 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 574598 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 574622 INFO (zkCallback-483-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2000a817
name:ZooKeeperConnection Watcher:127.0.0.1:51151 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 574622 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 574622 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 574622 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 574642 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 574654 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 574662 INFO (zkCallback-484-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@214bbc35
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 574662 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 574663 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 574663 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 574667 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 574667 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 574667 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 574668 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 574668 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 574669 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 574669 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 574670 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 574670 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 574671 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 574671 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 574671 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 574672 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 574672 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 574672 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 574673 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 574673 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 574674 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 574674 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 574674 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 574674 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 574679 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 574679 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 574680 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 574680 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 574681 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 574682 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 574686 INFO (zkCallback-485-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@70aa8297
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 574686 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 574686 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 574879 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1
[junit4] 2> 574939 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 574986 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@72b2d118{/,null,AVAILABLE}
[junit4] 2> 575004 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.u.s.SslContextFactory x509=X509@25cec2cb(solrtest,h=[],w=[]) for
SslContextFactory@4110fd7b(file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/server/etc/test/solrtest.keystore,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/server/etc/test/solrtest.keystore)
[junit4] 2> 575200 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.ServerConnector Started ServerConnector@48a218a1{SSL,[ssl,
http/1.1]}{127.0.0.1:49129}
[junit4] 2> 575200 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.Server Started @580673ms
[junit4] 2> 575200 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/tempDir-001/control/data,
hostContext=/, hostPort=49129,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores}
[junit4] 2> 575200 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 575200 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001'
[junit4] 2> 575221 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
(NoInitialContextEx)
[junit4] 2> 575221 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
find system property or JNDI)
[junit4] 2> 575221 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 575232 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 575234 INFO (zkCallback-486-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@47561fe5
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 575234 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 575235 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 575235 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 575235 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/solr.xml
[junit4] 2> 575239 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores
[junit4] 2> 575239 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CoreContainer New CoreContainer 1939842807
[junit4] 2> 575239 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001]
[junit4] 2> 575239 WARN
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/lib
[junit4] 2> 575240 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] 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> 575250 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 575255 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 575255 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 575255 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51151/solr
[junit4] 2> 575255 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 575255 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 575256 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 575266 INFO (zkCallback-489-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@32752e06
name:ZooKeeperConnection Watcher:127.0.0.1:51151 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 575266 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 575267 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 575534 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.ConnectionManager Waiting for client to
connect to ZooKeeper
[junit4] 2> 575538 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@460ecdb2
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 575546 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.ConnectionManager Client is connected to
ZooKeeper
[junit4] 2> 575547 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 575547 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 575548 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 575549 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 575550 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 575551 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 575551 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 575558 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /clusterstate.json
[junit4] 2> 575559 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 575559 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.ZkStateReader Updating cluster state from
ZooKeeper...
[junit4] 2> 575560 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 575560 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 575561 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 575561 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 575562 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.LeaderElector Joined leadership election with
path: /overseer_elect/election/95673589694988293-127.0.0.1:49129_-n_0000000000
[junit4] 2> 575562 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:49129_
[junit4] 2> 575562 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 575562 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.Overseer Overseer
(id=95673589694988293-127.0.0.1:49129_-n_0000000000) starting
[junit4] 2> 575563 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue-work
[junit4] 2> 575571 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.OverseerAutoReplicaFailoverThread Starting
OverseerAutoReplicaFailoverThread autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=30000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 575574 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.Overseer Starting to work on the main queue
[junit4] 2> 575575 INFO
(OverseerCollectionConfigSetProcessor-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.OverseerTaskProcessor Process current queue
of overseer operations
[junit4] 2> 575590 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49129_
[junit4] 2> 575597 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 575598 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:49129_
[junit4] 2> 575618 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] 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> 575618 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 575634 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.CoreContainer Security conf doesn't exist.
Skipping setup for authorization module.
[junit4] 2> 575634 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.CoreContainer No authentication plugin used.
[junit4] 2> 575638 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores
[junit4] 2> 575639 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] 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> 575639 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.CorePropertiesLocator Found core collection1
in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1
[junit4] 2> 575639 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
[junit4] 2> 575659 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 575659 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 575661 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 575661 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[n:127.0.0.1:49129_ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init()
done
[junit4] 2> 575661 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 575661 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.Overseer processMessage: queueSize: 1, message
= {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:49129";,
[junit4] 2> "node_name":"127.0.0.1:49129_",
[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> 575663 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.o.ReplicaMutator Update state numShards=1
message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"https://127.0.0.1:49129";,
[junit4] 2> "node_name":"127.0.0.1:49129_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 575666 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
control_collection
[junit4] 2> 575666 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 575667 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] 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> 576661 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
waiting to find shard id in clusterstate for collection1
[junit4] 2> 576661 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
Check for collection zkNode:control_collection
[junit4] 2> 576662 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.ZkController
Collection zkNode exists
[junit4] 2> 576662 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 576665 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 576665 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1'
[junit4] 2> 576665 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 576665 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 576666 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.Config loaded
config solrconfig.xml with version 0
[junit4] 2> 576674 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.SolrConfig
current version of requestparams : -1
[junit4] 2> 576677 WARN
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 576678 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.0.0
[junit4] 2> 576724 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 576740 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 577084 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 577092 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.s.IndexSchema
default search field in schema is text
[junit4] 2> 577093 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.s.IndexSchema
unique key field: id
[junit4] 2> 577158 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 577160 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 577167 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 577168 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 577173 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1
[junit4] 2> 577173 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 577174 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 577174 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/]
[junit4] 2> 577174 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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@68c6161b
[junit4] 2> 577178 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data
[junit4] 2> 577178 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/index/
[junit4] 2> 577178 WARN
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 577179 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/index
[junit4] 2> 577179 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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=3, maxMergeAtOnceExplicit=7, maxMergedSegmentMB=2.16796875,
floorSegmentMB=0.4150390625, forceMergeDeletesPctAllowed=3.029980953595426,
segmentsPerTier=13.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.887263938729532
[junit4] 2> 577194 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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@915d2ab
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d588fb0),segFN=segments_1,generation=1}
[junit4] 2> 577194 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 577196 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"nodistrib"
[junit4] 2> 577196 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"dedupe"
[junit4] 2> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain creating updateRequestProcessorChain
"stored_sig"
[junit4] 2> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577197 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577197 WARN
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577198 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49129_
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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/
[junit4] 2> 577198 WARN
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.DirectoryFactory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/control-001/cores/collection1/data/
does not point to a valid data directory; skipping clean-up of old index
directories.
[junit4] 2> 577216 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 577217 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 577223 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 577224 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 577239 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577239 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577240 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577240 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577240 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 577240 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 577250 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=16, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 577254 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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@915d2ab
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@d588fb0),segFN=segments_1,generation=1}
[junit4] 2> 577254 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 577254 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@6896c083[collection1] main]
[junit4] 2> 577254 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577255 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577255 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577255 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 577255 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 577255 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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> 577256 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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 1530777438023319552
[junit4] 2> 577258 INFO
(searcherExecutor-1214-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@6896c083[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 577258 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ 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
1530777438023319552
[junit4] 2> 577258 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 577259 INFO
(coreLoadExecutor-1213-thread-1-processing-n:127.0.0.1:49129_)
[n:127.0.0.1:49129_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 577347 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 577350 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:https://127.0.0.1:49129
collection:control_collection shard:shard1
[junit4] 2> 577351 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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> 577353 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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/95673589694988293-core_node1-n_0000000000
[junit4] 2> 577353 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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> 577359 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] 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> 577359 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] 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> 577362 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 577362 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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> 577362 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:49129/collection1/
[junit4] 2> 577362 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 577362 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
https://127.0.0.1:49129/collection1/ has no replicas
[junit4] 2> 577370 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 577370 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 577378 INFO (zkCallback-492-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@623d5e65
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 577378 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 577378 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 577378 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 577379 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 577379 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause
connection loss:false
[junit4] 2> 577379 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with
stateFormat=2
[junit4] 2> 577379 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 577387 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 577394 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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/95673589694988293-core_node1-n_0000000000
[junit4] 2> 577402 INFO (zkCallback-493-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@4a1f84cc
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 577402 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 577402 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 577402 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:49129/collection1/ shard1
[junit4] 2> 577403 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] 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":"https://127.0.0.1:49129";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 577411 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] 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: 2
[junit4] 2> 577411 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.o.ClusterStateMutator building a new cName:
collection1
[junit4] 2> 577411 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] 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> 577411 INFO (zkCallback-492-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> 577460 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are https://127.0.0.1:49129/collection1/ and leader is
https://127.0.0.1:49129/collection1/
[junit4] 2> 577460 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=https://127.0.0.1:49129
[junit4] 2> 577460 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 577460 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 577460 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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> 577461 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] 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":"https://127.0.0.1:49129";,
[junit4] 2> "node_name":"127.0.0.1:49129_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 577462 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] 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":"https://127.0.0.1:49129";,
[junit4] 2> "node_name":"127.0.0.1:49129_",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 577462 INFO
(OverseerStateUpdate-95673589694988293-127.0.0.1:49129_-n_0000000000)
[n:127.0.0.1:49129_ ] o.a.s.c.o.ZkStateWriter going to create_collection
/collections/collection1/state.json
[junit4] 2> 577466 INFO
(coreZkRegister-1207-thread-1-processing-n:127.0.0.1:49129_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:49129_
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> 577565 INFO
(zkCallback-490-thread-1-processing-n:127.0.0.1:49129_) [n:127.0.0.1:49129_
] 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> 577566 INFO (zkCallback-492-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> 577607 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001/cores/collection1
[junit4] 2> 577608 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001
[junit4] 2> 577609 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 577610 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@43e35961{/,null,AVAILABLE}
[junit4] 2> 577610 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.u.s.SslContextFactory x509=X509@7e124e3d(solrtest,h=[],w=[]) for
SslContextFactory@30596e35(file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/server/etc/test/solrtest.keystore,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/server/etc/test/solrtest.keystore)
[junit4] 2> 577619 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.ServerConnector Started ServerConnector@1257f81e{SSL,[ssl,
http/1.1]}{127.0.0.1:43991}
[junit4] 2> 577619 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.e.j.s.Server Started @583092ms
[junit4] 2> 577619 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=43991,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001/cores}
[junit4] 2> 577619 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 577619 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001'
[junit4] 2> 577620 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader JNDI not configured for solr
(NoInitialContextEx)
[junit4] 2> 577620 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not
find system property or JNDI)
[junit4] 2> 577620 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 577639 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 577646 INFO (zkCallback-494-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@36b1dd7b
name:ZooKeeperConnection Watcher:127.0.0.1:51151/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 577646 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 577646 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 577648 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 577648 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001/solr.xml
[junit4] 2> 577657 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.CollectionsAPIAsyncDistributedZkTest_EE656BC9F832E2A4-001/shard-1-001/cores
[junit4] 2> 577657 INFO
(TEST-CollectionsAPIAsyncDistributedZkTest.testAsyncRequests-seed#[EE656BC9F832E2A4])
[ ] o.a.s.c.CoreConta
[...truncated too long message...]
8)
[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.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:52)
[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:498)
[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> 6504710 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[EE656BC9F832E2A4]-worker) [
] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> Apr 05, 2016 3:10:54 PM
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=Memory doPackFST= false),
range_facet_l_dv=PostingsFormat(name=LuceneFixedGap),
_version_=PostingsFormat(name=Memory doPackFST= false),
multiDefault=PostingsFormat(name=LuceneVarGapDocFreqInterval),
a_t=PostingsFormat(name=Memory doPackFST= false),
intDefault=PostingsFormat(name=Memory doPackFST= false),
a_i1=PostingsFormat(name=Memory doPackFST= false),
id=PostingsFormat(name=LuceneFixedGap),
range_facet_i_dv=PostingsFormat(name=Memory doPackFST= false),
text=PostingsFormat(name=Memory doPackFST= true),
range_facet_l=PostingsFormat(name=Memory doPackFST= false),
timestamp=PostingsFormat(name=Memory doPackFST= false)},
docValues:{range_facet_l_dv=DocValuesFormat(name=Lucene54),
range_facet_i_dv=DocValuesFormat(name=Lucene54),
timestamp=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=30,
maxMBSortInHeap=5.947108748414875, sim=ClassicSimilarity, locale=sr-Latn-ME,
timezone=SystemV/AST4ADT
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_74 (64-bit)/cpus=4,threads=2,free=125702176,total=523763712
[junit4] 2> NOTE: All tests run in this JVM:
[TestCursorMarkWithoutUniqueKey, SolrPluginUtilsTest, HdfsThreadLeakTest,
AsyncMigrateRouteKeyTest, SpatialRPTFieldTypeTest, InfoHandlerTest,
SimpleCollectionCreateDeleteTest, TestNoOpRegenerator, TestSQLHandler,
UniqFieldsUpdateProcessorFactoryTest, ChaosMonkeySafeLeaderTest,
TestReplicationHandlerBackup, GraphQueryTest, TimeZoneUtilsTest,
TestQuerySenderNoQuery, TestUpdate, HdfsDirectoryTest,
TestDynamicFieldCollectionResource, MoreLikeThisHandlerTest,
SoftAutoCommitTest, TestHashPartitioner, TestPartialUpdateDeduplication,
TestDocBasedVersionConstraints, TermsComponentTest, TestSolrQueryResponse,
WordBreakSolrSpellCheckerTest, TestBinaryResponseWriter,
SpellCheckCollatorTest, TestManagedResourceStorage, IndexBasedSpellCheckerTest,
TestSchemaNameResource, TestMiniSolrCloudClusterBase,
ConjunctionSolrSpellCheckerTest, DeleteInactiveReplicaTest,
SuggestComponentContextFilterQueryTest, SpatialFilterTest,
TestDistributedGrouping, TestBM25SimilarityFactory,
CollectionsAPIAsyncDistributedZkTest, TestManagedSynonymFilterFactory,
ShardSplitTest, TestLMJelinekMercerSimilarityFactory, TestStressVersions,
TestCodecSupport, SortSpecParsingTest, TestImplicitCoreProperties,
TestConfigSetProperties, NotRequiredUniqueKeyTest, CoreAdminCreateDiscoverTest,
TestSolrQueryParserResource, TestDefaultStatsCache, TestSchemaVersionResource,
ZkControllerTest, SortByFunctionTest, DistributedTermsComponentTest,
ClusterStateUpdateTest, CheckHdfsIndexTest, QueryResultKeyTest, DocValuesTest,
BasicFunctionalityTest, DistributedIntervalFacetingTest, TestRTimerTree,
TestRequestForwarding, DistributedVersionInfoTest, JavabinLoaderTest,
TestOrdValues, TestXmlQParser, TestExactStatsCache,
DistributedFacetPivotWhiteBoxTest, TriLevelCompositeIdRoutingTest, TestNRTOpen,
ZkStateReaderTest, TestWordDelimiterFilterFactory, CSVRequestHandlerTest,
DistributedMLTComponentTest, DistributedFacetPivotLongTailTest,
PKIAuthenticationIntegrationTest, SpellingQueryConverterTest,
TestRuleBasedAuthorizationPlugin, HighlighterTest, TestExpandComponent,
TestManagedSchema, DistanceFunctionTest, TestFastLRUCache, TestRecoveryHdfs,
SolrInfoMBeanTest, HLLUtilTest, BlockJoinFacetDistribTest,
TestSolrDeletionPolicy2, CloneFieldUpdateProcessorFactoryTest, FileUtilsTest,
DirectSolrSpellCheckerTest, BasicDistributedZkTest, BasicDistributedZk2Test,
CollectionsAPIDistributedZkTest, LeaderElectionIntegrationTest,
ShardRoutingTest, RecoveryZkTest, TestReplicationHandler,
CloudExitableDirectoryReaderTest, CollectionReloadTest,
ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest,
DistribDocExpirationUpdateProcessorTest, DistributedQueueTest, ForceLeaderTest,
MigrateRouteKeyTest, OutOfBoxZkACLAndCredentialsProvidersTest,
OverriddenZkACLAndCredentialsProvidersTest,
OverseerCollectionConfigSetProcessorTest, OverseerRolesTest,
OverseerStatusTest, OverseerTaskQueueTest, RecoveryAfterSoftCommitTest,
RemoteQueryErrorTest, ReplicationFactorTest, RestartWhileUpdatingTest,
SharedFSAutoReplicaFailoverUtilsTest, SolrCloudExampleTest,
TestAuthenticationFramework, TestCollectionAPI, TestDistribDocBasedVersion,
TestExclusionRuleCollectionAccess, TestMiniSolrCloudClusterSSL,
TestRandomRequestDistribution, TestRequestStatusCollectionAPI,
TestSizeLimitedDistributedMap, HdfsChaosMonkeySafeLeaderTest,
HdfsCollectionsAPIDistributedZkTest]
[junit4] Completed [482/579 (5!)] on J1 in 621.67s, 1 test, 1 error <<<
FAILURES!
[...truncated 334 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/common-build.xml:527:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1014:
There were test failures: 579 suites (10 ignored), 2309 tests, 1 suite-level
error, 3 errors, 1 failure, 31 ignored (16 assumptions) [seed: EE656BC9F832E2A4]
Total time: 311 minutes 37 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
