Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/20/
3 tests failed.
FAILED: org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test
Error Message:
Exactly one shard should have changed, instead: [shard2, shard1]
nodes=([core_node3(shard2), core_node2(shard1), core_node4(shard1)])
expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: Exactly one shard should have changed, instead:
[shard2, shard1] nodes=([core_node3(shard2), core_node2(shard1),
core_node4(shard1)]) expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([9962B2F0FAE69E4D:11368D2A541AF3B5]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at
org.apache.solr.cloud.DistribDocExpirationUpdateProcessorTest.test(DistribDocExpirationUpdateProcessorTest.java:118)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.handler.TestReplicationHandler.doTestStressReplication
Error Message:
[index.20160322224721130, index.20160322224716738, replication.properties,
index.properties] expected:<1> but was:<2>
Stack Trace:
java.lang.AssertionError: [index.20160322224721130, index.20160322224716738,
replication.properties, index.properties] expected:<1> but was:<2>
at
__randomizedtesting.SeedInfo.seed([9962B2F0FAE69E4D:42C9B236FFCEF7FE]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.junit.Assert.assertEquals(Assert.java:472)
at
org.apache.solr.handler.TestReplicationHandler.checkForSingleIndex(TestReplicationHandler.java:823)
at
org.apache.solr.handler.TestReplicationHandler.doTestStressReplication(TestReplicationHandler.java:790)
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
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:
Error from server at https://127.0.0.1:58984/di/j: KeeperErrorCode = Session
expired for /overseer/collection-queue-work/qnr-0000000110
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at https://127.0.0.1:58984/di/j: KeeperErrorCode = Session expired
for /overseer/collection-queue-work/qnr-0000000110
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.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1547)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1602)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.deleteCollectionWithDownNodes(CollectionsAPIDistributedZkTest.java:338)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:175)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:996)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:971)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 11444 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/init-core-data-001
[junit4] 2> 221514 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true)
[junit4] 2> 221514 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /di/j
[junit4] 2> 222407 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 223392 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 223667 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
[junit4] 2> 223677 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 223770 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 223875 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_57848_hdfs____.91ub98/webapp
[junit4] 2> 224052 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 224694 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:57848
[junit4] 2> 225822 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 225828 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 225842 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_53039_datanode____cgu59b/webapp
[junit4] 2> 225955 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 226307 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53039
[junit4] 2> 226556 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 226558 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 226574 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_45591_datanode____fhd61f/webapp
[junit4] 2> 226693 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 227053 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[9962B2F0FAE69E4D]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:45591
[junit4] 2> 227571 INFO (IPC Server handler 8 on 55945) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-035ce313-4815-4120-bdbd-326331be933b node DatanodeRegistration(127.0.0.1,
datanodeUuid=02f09424-4870-4452-80ef-e87764341a3e, infoPort=53039,
ipcPort=52030, storageInfo=lv=-56;cid=testClusterID;nsid=92491539;c=0), blocks:
0, hasStaleStorages: true, processing time: 1 msecs
[junit4] 2> 227571 INFO (IPC Server handler 7 on 55945) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-14e36be6-90fb-438a-b45b-1d787e809da2 node DatanodeRegistration(127.0.0.1,
datanodeUuid=7c7e9f86-b300-4422-a720-020fbc92eaab, infoPort=45591,
ipcPort=37372, storageInfo=lv=-56;cid=testClusterID;nsid=92491539;c=0), blocks:
0, hasStaleStorages: true, processing time: 4 msecs
[junit4] 2> 227571 INFO (IPC Server handler 8 on 55945) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-55cf0456-721d-4204-bc68-2e75fef00779 node DatanodeRegistration(127.0.0.1,
datanodeUuid=02f09424-4870-4452-80ef-e87764341a3e, infoPort=53039,
ipcPort=52030, storageInfo=lv=-56;cid=testClusterID;nsid=92491539;c=0), blocks:
0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 227576 INFO (IPC Server handler 7 on 55945) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-d2accda1-9c60-453f-926a-b802f8f16b40 node DatanodeRegistration(127.0.0.1,
datanodeUuid=7c7e9f86-b300-4422-a720-020fbc92eaab, infoPort=45591,
ipcPort=37372, storageInfo=lv=-56;cid=testClusterID;nsid=92491539;c=0), blocks:
0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 228215 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 228215 INFO (Thread-717) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 228216 INFO (Thread-717) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 228315 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.ZkTestServer start zk server on port:57219
[junit4] 2> 228315 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 228317 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 228324 INFO (zkCallback-279-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@634aab06
name:ZooKeeperConnection Watcher:127.0.0.1:57219 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 228326 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 228326 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 228326 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 228332 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 228333 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 228334 INFO (zkCallback-280-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1926bf6 name:ZooKeeperConnection
Watcher:127.0.0.1:57219/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 228334 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 228334 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 228334 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 228343 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 228344 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 228345 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 228346 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 228346 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 228348 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 228348 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 228350 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 228350 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 228351 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 228351 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 228352 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 228352 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 228353 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 228354 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 228355 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 228355 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 228356 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 228356 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 228357 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 228357 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 228358 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 228358 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 228359 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 228360 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 228361 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 228363 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 228364 INFO (zkCallback-281-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@b549637 name:ZooKeeperConnection
Watcher:127.0.0.1:57219/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 228364 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 228364 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 228475 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores/collection1
[junit4] 2> 228479 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 228481 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@661e50a5{/di/j,null,AVAILABLE}
[junit4] 2> 228482 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.u.s.SslContextFactory x509=X509@415627b2(solrtest,h=[],w=[]) for
SslContextFactory@50453f6b(file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore)
[junit4] 2> 228487 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.ServerConnector Started ServerConnector@19d9a0a6{SSL,[ssl,
http/1.1]}{127.0.0.1:32799}
[junit4] 2> 228488 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.Server Started @233975ms
[junit4] 2> 228488 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:55945/hdfs__localhost_55945__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001_tempDir-002_control_data,
hostContext=/di/j, hostPort=32799,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores}
[junit4] 2> 228489 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 228489 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001'
[junit4] 2> 228489 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 228489 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 228489 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 228490 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 228497 INFO (zkCallback-282-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@811cc28 name:ZooKeeperConnection
Watcher:127.0.0.1:57219/solr got event WatchedEvent state:SyncConnected
type:None path:null path:null type:None
[junit4] 2> 228497 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 228498 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 228500 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 228500 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/solr.xml
[junit4] 2> 228517 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores
[junit4] 2> 228517 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.CoreContainer New CoreContainer 155628692
[junit4] 2> 228517 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001]
[junit4] 2> 228519 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/lib
[junit4] 2> 228519 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
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> 228529 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 228531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 228531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 228531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:57219/solr
[junit4] 2> 228531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 228531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 228532 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 228532 INFO (zkCallback-285-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@49228d0 name:ZooKeeperConnection
Watcher:127.0.0.1:57219 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 228533 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 228533 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 228535 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 228535 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@48a9c08b
name:ZooKeeperConnection Watcher:127.0.0.1:57219/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 228535 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 228536 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 228538 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 228541 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 228542 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 228544 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 228547 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 228548 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 228549 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 228550 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath: /security.json
[junit4] 2> 228550 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 228551 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (0)
[junit4] 2> 228553 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 228559 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 228560 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 228560 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.LeaderElector Joined leadership election
with path:
/overseer_elect/election/95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000
[junit4] 2> 228560 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:32799_di%2Fj
[junit4] 2> 228560 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 228561 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.Overseer Overseer
(id=95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000) starting
[junit4] 2> 228562 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 228567 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 228572 INFO
(OverseerCollectionConfigSetProcessor-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.OverseerTaskProcessor Process current
queue of overseer operations
[junit4] 2> 228572 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 228573 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:32799_di%2Fj
[junit4] 2> 228574 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:32799_di%2Fj
[junit4] 2> 228575 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] 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> 228577 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 228577 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (1)
[junit4] 2> 228584 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 228584 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 228585 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.CorePropertiesLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores
[junit4] 2> 228586 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] 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> 228586 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.CorePropertiesLocator Found core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores/collection1
[junit4] 2> 228586 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 228596 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 228596 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 228598 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 228610 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1
[junit4] 2> 228610 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D])
[n:127.0.0.1:32799_di%2Fj ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 228610 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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:32799/di/j";,
[junit4] 2> "node_name":"127.0.0.1:32799_di%2Fj",
[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> 228611 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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:32799/di/j";,
[junit4] 2> "node_name":"127.0.0.1:32799_di%2Fj",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 228612 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 228612 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 228613 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] 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> 229598 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 229598 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores/collection1'
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 229599 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 229601 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 229617 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 229623 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.1.0
[junit4] 2> 229635 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 229642 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 229757 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 229763 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 229764 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 229787 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 229789 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 229791 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 229791 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 229793 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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.x/solr/build/solr-core/test/J1
[junit4] 2> 229793 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 229793 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
[junit4] 2> 229807 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:55945/solr_hdfs_home
[junit4] 2> 229807 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication
disabled
[junit4] 2> 229807 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/control-001/cores/collection1],
dataDir=[hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 229807 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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@37e52734
[junit4] 2> 229807 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 229869 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 229874 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index/
[junit4] 2> 229896 WARN
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'hdfs:/localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 229896 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 229919 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 229919 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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=22, maxMergeAtOnceExplicit=18, maxMergedSegmentMB=82.72265625,
floorSegmentMB=0.236328125, forceMergeDeletesPctAllowed=8.61867506135849,
segmentsPerTier=36.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.17750991538412403
[junit4] 2> 230226 INFO (IPC Server handler 7 on 55945) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:45842 is
added to blk_1073741825_1001{blockUCState=COMMITTED, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-55cf0456-721d-4204-bc68-2e75fef00779:NORMAL:127.0.0.1:45842|RBW],
ReplicaUnderConstruction[[DISK]DS-d2accda1-9c60-453f-926a-b802f8f16b40:NORMAL:127.0.0.1:56798|RBW]]}
size 71
[junit4] 2> 230227 INFO (IPC Server handler 8 on 55945) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:56798 is
added to blk_1073741825_1001 size 71
[junit4] 2> 230633 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56a792b3;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 230633 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 230647 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 230647 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 230647 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 230647 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 230647 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 230648 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230648 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230656 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230656 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230656 WARN
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230658 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230659 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230669 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230670 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 230670 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:32799_di%2Fj
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
hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/
[junit4] 2> 230695 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230695 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230708 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 230708 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230708 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog:
tlogDfsReplication=2
[junit4] 2> 230743 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 230743 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 230750 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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=8, maxMergeAtOnceExplicit=6, maxMergedSegmentMB=83.59375,
floorSegmentMB=0.7666015625, forceMergeDeletesPctAllowed=10.926919825893409,
segmentsPerTier=12.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.5995912217994458
[junit4] 2> 230892 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:55945/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@56a792b3;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 230892 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 230893 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@2c359140[collection1] main]
[junit4] 2> 230893 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230894 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230894 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230894 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 230894 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 230894 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230895 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230895 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230895 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 230897 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 230900 INFO
(searcherExecutor-902-thread-1-processing-n:127.0.0.1:32799_di%2Fj
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2c359140[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 230901 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230901 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230901 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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> 230901 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj 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 1529575935521587200
[junit4] 2> 230903 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 1.0ms to seed version buckets with
highest version 1529575935521587200
[junit4] 2> 230903 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 230903 INFO
(coreLoadExecutor-901-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 230912 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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:32799/di/j
collection:control_collection shard:shard1
[junit4] 2> 230913 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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> 230917 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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/95598495794659333-core_node1-n_0000000000
[junit4] 2> 230917 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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=180000
[junit4] 2> 230919 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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> 230920 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] 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> 230922 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 230922 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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> 230922 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to https://127.0.0.1:32799/di/j/collection1/
[junit4] 2> 230922 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 230922 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
https://127.0.0.1:32799/di/j/collection1/ has no replicas
[junit4] 2> 230923 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 230925 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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/95598495794659333-core_node1-n_0000000000
[junit4] 2> 230926 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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:32799/di/j";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 230928 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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:32799/di/j/collection1/ shard1
[junit4] 2> 231029 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] 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> 231030 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are https://127.0.0.1:32799/di/j/collection1/ and leader is
https://127.0.0.1:32799/di/j/collection1/
[junit4] 2> 231030 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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:32799/di/j
[junit4] 2> 231030 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 231030 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 231030 INFO
(coreZkRegister-895-thread-1-processing-n:127.0.0.1:32799_di%2Fj x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:32799_di%2Fj
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> 231032 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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:32799/di/j";,
[junit4] 2> "node_name":"127.0.0.1:32799_di%2Fj",
[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> 231032 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] 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:32799/di/j";,
[junit4] 2> "node_name":"127.0.0.1:32799_di%2Fj",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 231116 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 231116 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 231120 INFO (zkCallback-288-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@37ca3751
name:ZooKeeperConnection Watcher:127.0.0.1:57219/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 231120 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 231120 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 231121 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 231122 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 231122 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 231122 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 231122 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 231128 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 231128 INFO (zkCallback-289-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@2083022a
name:ZooKeeperConnection Watcher:127.0.0.1:57219/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 231128 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 231128 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 231132 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"create",
[junit4] 2> "name":"collection1",
[junit4] 2> "numShards":"2",
[junit4] 2> "stateFormat":"2"} current state version: 3
[junit4] 2> 231132 INFO
(OverseerStateUpdate-95598495794659333-127.0.0.1:32799_di%2Fj-n_0000000000)
[n:127.0.0.1:32799_di%2Fj ] o.a.s.c.o.ClusterStateMutator building a new
cName: collection1
[junit4] 2> 231133 INFO
(zkCallback-286-thread-1-processing-n:127.0.0.1:32799_di%2Fj)
[n:127.0.0.1:32799_di%2Fj ] 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> 231133 INFO (zkCallback-288-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> 231223 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/shard-1-001/cores/collection1
[junit4] 2> 231223 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/shard-1-001
[junit4] 2> 231225 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 231230 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@7acc34af{/di/j,null,AVAILABLE}
[junit4] 2> 231231 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.u.s.SslContextFactory x509=X509@3f6dff69(solrtest,h=[],w=[]) for
SslContextFactory@3062ac63(file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore,file:///x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/server/etc/test/solrtest.keystore)
[junit4] 2> 231235 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.ServerConnector Started ServerConnector@46b276e4{SSL,[ssl,
http/1.1]}{127.0.0.1:58984}
[junit4] 2> 231238 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.e.j.s.Server Started @236725ms
[junit4] 2> 231238 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:55945/hdfs__localhost_55945__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/di/j, hostPort=58984,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/shard-1-001/cores}
[junit4] 2> 231239 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 231239 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[9962B2F0FAE69E4D]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_9962B2F0FAE69E4D-001/shard-1-001'
[j
[...truncated too long message...]
e-027/./collection1/data/index;done=false>>]
[junit4] 2> 2617033 INFO (coreCloseExecutor-6461-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-027/./collection1/data/index
[junit4] 2> 2617033 INFO (coreCloseExecutor-6461-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-027/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-027/./collection1/data;done=false>>]
[junit4] 2> 2617033 INFO (coreCloseExecutor-6461-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-027/./collection1/data
[junit4] 2> 2617033 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[9962B2F0FAE69E4D])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@72165dbe{/solr,null,UNAVAILABLE}
[junit4] 2> 2617037 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[9962B2F0FAE69E4D])
[ ] o.e.j.s.ServerConnector Stopped
ServerConnector@445c342{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 2617037 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[9962B2F0FAE69E4D])
[ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=235538982
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@31a1bc2f
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.u.DirectUpdateHandler2 closing
DirectUpdateHandler2{commits=5,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached
0 - closing IndexWriter
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.u.DefaultSolrCoreState closing IndexWriter with
IndexWriterCloser
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing MockDirectoryFactory - 2
directories currently being tracked
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data;done=false>>]
[junit4] 2> 2617038 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data
[junit4] 2> 2617039 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data/index;done=false>>]
[junit4] 2> 2617039 INFO (coreCloseExecutor-6463-thread-1) [
x:collection1] o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001/solr-instance-028/./collection1/data/index
[junit4] 2> 2617040 INFO
(TEST-TestReplicationHandler.doTestReplicateAfterWrite2Slave-seed#[9962B2F0FAE69E4D])
[ ] o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@6df8d2e5{/solr,null,UNAVAILABLE}
[junit4] 2> 2617041 INFO
(SUITE-TestReplicationHandler-seed#[9962B2F0FAE69E4D]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build/solr-core/test/J1/temp/solr.handler.TestReplicationHandler_9962B2F0FAE69E4D-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene60):
{name=Lucene50(blocksize=128), id=Lucene50(blocksize=128),
newname=Lucene50(blocksize=128)}, docValues:{}, maxPointsInLeafNode=854,
maxMBSortInHeap=4.726403366139456, sim=ClassicSimilarity, locale=nl-NL,
timezone=America/Adak
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_74 (64-bit)/cpus=4,threads=1,free=220328120,total=525336576
[junit4] 2> NOTE: All tests run in this JVM: [TestNRTOpen,
DirectSolrSpellCheckerTest, ChaosMonkeySafeLeaderTest,
SpellPossibilityIteratorTest, TestLMJelinekMercerSimilarityFactory,
TestFieldTypeResource, OpenExchangeRatesOrgProviderTest,
WordBreakSolrSpellCheckerTest, SolrIndexSplitterTest, TestSolrCoreProperties,
DOMUtilTest, SoftAutoCommitTest, MinimalSchemaTest, TestCoreContainer,
ZkSolrClientTest, TestFreeTextSuggestions, TestRequestForwarding,
TestCodecSupport, TestAuthorizationFramework, FileUtilsTest,
TestImplicitCoreProperties, TestWordDelimiterFilterFactory,
TestDocumentBuilder, DocumentBuilderTest, TestSha256AuthenticationProvider,
TestCustomDocTransformer, TestCustomSort, TestCloudManagedSchema,
TestMissingGroups, TestBM25SimilarityFactory,
HdfsCollectionsAPIDistributedZkTest, CloudMLTQParserTest, RankQueryTest,
TestQueryWrapperFilter, DeleteInactiveReplicaTest, HdfsLockFactoryTest,
TestScoreJoinQPNoScore, IndexBasedSpellCheckerTest, TestExceedMaxTermLength,
TestDFISimilarityFactory, SchemaVersionSpecificBehaviorTest,
TestCursorMarkWithoutUniqueKey, DistribDocExpirationUpdateProcessorTest,
DistributedIntervalFacetingTest, TestStressUserVersions, TestFiltering,
TestSQLHandler, TestConfigSetsAPIExclusivity, CheckHdfsIndexTest,
TestSolrConfigHandler, SimpleCollectionCreateDeleteTest, CSVRequestHandlerTest,
TestManagedResource, OverseerStatusTest, TestUpdate,
TestEmbeddedSolrServerConstructors, InfoHandlerTest, SpatialFilterTest,
TestFieldCollectionResource, ConvertedLegacyTest, MBeansHandlerTest,
TestStressVersions, TestLRUStatsCache, TestUseDocValuesAsStored,
TimeZoneUtilsTest, ZkCLITest, TestManagedStopFilterFactory,
TestConfigSetProperties, UUIDUpdateProcessorFallbackTest, TestCloudPivotFacet,
FastVectorHighlighterTest, RequestLoggingTest, TestReplicationHandlerBackup,
TestSystemIdResolver, TestHashPartitioner,
CloneFieldUpdateProcessorFactoryTest,
OverriddenZkACLAndCredentialsProvidersTest, TestExpandComponent,
TestSurroundQueryParser, SuggestComponentContextFilterQueryTest, MultiTermTest,
QueryResultKeyTest, DistanceFunctionTest, TestDistributedGrouping,
TestRawTransformer, TestJsonFacets, TestDistribDocBasedVersion,
RemoteQueryErrorTest, ZkStateReaderTest, AliasIntegrationTest,
TestQuerySenderListener, TermsComponentTest, ExplicitHLLTest,
BasicDistributedZkTest, CollectionsAPIDistributedZkTest, OverseerTest,
LeaderElectionIntegrationTest, ShardRoutingTest, RecoveryZkTest,
TestReplicationHandler]
[junit4] Completed [422/582 (3!)] on J1 in 539.53s, 13 tests, 1 failure <<<
FAILURES!
[...truncated 554 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/solr/common-build.xml:529:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/lucene/common-build.xml:1014:
There were test failures: 582 suites (10 ignored), 2331 tests, 1 error, 2
failures, 32 ignored (16 assumptions) [seed: 9962B2F0FAE69E4D]
Total time: 215 minutes 18 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
