Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Solaris/960/
Java: 64bit/jdk1.8.0 -XX:+UseCompressedOops -XX:+UseSerialGC
3 tests failed.
FAILED:
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail
Error Message:
expected:<200> but was:<404>
Stack Trace:
java.lang.AssertionError: expected:<200> but was:<404>
at
__randomizedtesting.SeedInfo.seed([D2B24768EBA4448B:BA0D72423B3E5667]: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.junit.Assert.assertEquals(Assert.java:456)
at
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.cancelDelegationToken(TestSolrCloudWithDelegationTokens.java:140)
at
org.apache.solr.cloud.TestSolrCloudWithDelegationTokens.testDelegationTokenCancelFail(TestSolrCloudWithDelegationTokens.java:294)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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.StressHdfsTest.test
Error Message:
Error from server at http://127.0.0.1:58922: Could not fully remove collection:
delete_data_dir
Stack Trace:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:58922: Could not fully remove collection:
delete_data_dir
at
__randomizedtesting.SeedInfo.seed([D2B24768EBA4448B:5AE678B245582973]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:610)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:439)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:391)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1288)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:1058)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:1000)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.hdfs.StressHdfsTest.createAndDeleteCollection(StressHdfsTest.java:220)
at
org.apache.solr.cloud.hdfs.StressHdfsTest.test(StressHdfsTest.java:103)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:985)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:960)
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:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
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.update.AutoCommitTest.testMaxTime
Error Message:
Exception during query
Stack Trace:
java.lang.RuntimeException: Exception during query
at
__randomizedtesting.SeedInfo.seed([D2B24768EBA4448B:48463A8A753ED8B7]:0)
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:812)
at
org.apache.solr.update.AutoCommitTest.testMaxTime(AutoCommitTest.java:270)
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:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
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:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.lang.RuntimeException: REQUEST FAILED:
xpath=//result[@numFound=1]
xml response was: <?xml version="1.0" encoding="UTF-8"?>
<response>
<lst name="responseHeader"><int name="status">0</int><int
name="QTime">0</int></lst><result name="response" numFound="0"
start="0"></result>
</response>
request was:q=id:529&qt=standard&start=0&rows=20&version=2.2
at org.apache.solr.SolrTestCaseJ4.assertQ(SolrTestCaseJ4.java:805)
... 40 more
Build Log:
[...truncated 10881 lines...]
[junit4] Suite: org.apache.solr.cloud.hdfs.StressHdfsTest
[junit4] 2> Creating dataDir:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/init-core-data-001
[junit4] 2> 309051 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 309052 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 309096 WARN
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 309103 WARN
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 309104 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 309116 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_solaris.vm_36538_hdfs____hc90h5/webapp
[junit4] 2> 309654 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@solaris-vm:36538
[junit4] 2> 309803 WARN
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 309806 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 309834 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_37060_datanode____nju1v1/webapp
[junit4] 2> 310402 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:37060
[junit4] 2> 310533 WARN
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 310534 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log
jetty-6.1.26
[junit4] 2> 310547 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Extract
jar:file:/export/home/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_53431_datanode____8ybgnv/webapp
[junit4] 2> 310644 INFO (IPC Server handler 7 on 53673) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-a57cbd08-be16-4d21-beef-e70654a2beca node
DatanodeRegistration(127.0.0.1:64527,
datanodeUuid=d513892c-1281-4c6f-ba14-d1978bf07f44, infoPort=38584,
infoSecurePort=0, ipcPort=34735,
storageInfo=lv=-56;cid=testClusterID;nsid=418953656;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 310644 INFO (IPC Server handler 7 on 53673) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-1eb28edb-c233-45b4-aed1-56402e4dd49c node
DatanodeRegistration(127.0.0.1:64527,
datanodeUuid=d513892c-1281-4c6f-ba14-d1978bf07f44, infoPort=38584,
infoSecurePort=0, ipcPort=34735,
storageInfo=lv=-56;cid=testClusterID;nsid=418953656;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 311151 INFO
(SUITE-StressHdfsTest-seed#[D2B24768EBA4448B]-worker) [ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:53431
[junit4] 2> 311314 INFO (IPC Server handler 8 on 53673) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-fbe16b57-9c72-4e8d-b88a-5f4dd17c8c90 node
DatanodeRegistration(127.0.0.1:50389,
datanodeUuid=25623a32-71cb-4984-b6d1-1056f122fe60, infoPort=63333,
infoSecurePort=0, ipcPort=41165,
storageInfo=lv=-56;cid=testClusterID;nsid=418953656;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 311314 INFO (IPC Server handler 8 on 53673) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-48319414-c43d-4d18-806d-e246910e8177 node
DatanodeRegistration(127.0.0.1:50389,
datanodeUuid=25623a32-71cb-4984-b6d1-1056f122fe60, infoPort=63333,
infoSecurePort=0, ipcPort=41165,
storageInfo=lv=-56;cid=testClusterID;nsid=418953656;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 311438 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ZkTestServer
STARTING ZK TEST SERVER
[junit4] 2> 311439 INFO (Thread-616) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 311439 INFO (Thread-616) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 311538 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ZkTestServer
start zk server on port:55352
[junit4] 2> 311557 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 311565 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 311567 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 311571 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 311573 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 311576 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 311578 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 311581 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 311584 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 311586 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 311589 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractZkTestCase put
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 311754 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.SolrTestCaseJ4
Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/cores/collection1
[junit4] 2> 311755 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
jetty-9.3.8.v20160314
[junit4] 2> 311757 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@28cf0d9{/,null,AVAILABLE}
[junit4] 2> 311757 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@a5e54d3{HTTP/1.1,[http/1.1]}{127.0.0.1:34057}
[junit4] 2> 311757 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
Started @315475ms
[junit4] 2> 311757 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://solaris-vm:53673/hdfs__solaris-vm_53673__export_home_jenkins_workspace_Lucene-Solr-master-Solaris_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001_tempDir-002_control_data,
hostContext=/, hostPort=34057,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/cores}
[junit4] 2> 311758 ERROR
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 311759 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 311759 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 311759 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 311759 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-21T13:34:39.950Z
[junit4] 2> 311764 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 311765 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.SolrXmlConfig
Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/solr.xml
[junit4] 2> 311771 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:55352/solr
[junit4] 2> 311817 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:34057_ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:34057_
[junit4] 2> 311819 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:34057_ ]
o.a.s.c.Overseer Overseer (id=96975931285897220-127.0.0.1:34057_-n_0000000000)
starting
[junit4] 2> 311831 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:34057_ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34057_
[junit4] 2> 311861 INFO
(zkCallback-356-thread-1-processing-n:127.0.0.1:34057_) [n:127.0.0.1:34057_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 311998 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:34057_ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/cores
[junit4] 2> 311998 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:34057_ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 312005 INFO
(OverseerStateUpdate-96975931285897220-127.0.0.1:34057_-n_0000000000)
[n:127.0.0.1:34057_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 313018 WARN
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 313019 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 313030 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 313109 WARN
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 313111 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 313132 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 313144 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://solaris-vm:53673/solr_hdfs_home
[junit4] 2> 313144 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 313145 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/cores/collection1],
dataDir=[hdfs://solaris-vm:53673/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 313145 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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@71e3acdb
[junit4] 2> 313145 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/control_collection/core_node1/data/snapshot_metadata
[junit4] 2> 313167 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 313167 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 313167 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new global HDFS BlockCache
[junit4] 2> 315189 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 315197 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 315225 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 315233 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 315233 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 315239 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 315240 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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=14, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=97.2197265625,
floorSegmentMB=0.69140625, forceMergeDeletesPctAllowed=3.9669638217323113,
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 315279 INFO (IPC Server handler 2 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:64527 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-48319414-c43d-4d18-806d-e246910e8177:NORMAL:127.0.0.1:50389|RBW],
ReplicaUC[[DISK]DS-a57cbd08-be16-4d21-beef-e70654a2beca:NORMAL:127.0.0.1:64527|FINALIZED]]}
size 0
[junit4] 2> 315280 INFO (IPC Server handler 1 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50389 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-48319414-c43d-4d18-806d-e246910e8177:NORMAL:127.0.0.1:50389|RBW],
ReplicaUC[[DISK]DS-a57cbd08-be16-4d21-beef-e70654a2beca:NORMAL:127.0.0.1:64527|FINALIZED]]}
size 0
[junit4] 2> 315309 WARN
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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> 315331 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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> 315331 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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> 315331 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 315364 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 315364 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 315366 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 315457 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@126fa84e[collection1] main]
[junit4] 2> 315458 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 315459 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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> 315462 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 315464 INFO
(searcherExecutor-1086-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
[collection1] Registered new searcher Searcher@126fa84e[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 315464 INFO
(coreLoadExecutor-1085-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ 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 1551614904793825280
[junit4] 2> 315477 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 315477 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
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> 315477 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:34057/collection1/
[junit4] 2> 315477 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 315478 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:34057/collection1/ has no replicas
[junit4] 2> 315487 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:34057/collection1/ shard1
[junit4] 2> 315512 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 315514 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ChaosMonkey
monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 315514 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 315538 INFO
(coreZkRegister-1078-thread-1-processing-n:127.0.0.1:34057_ x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:34057_
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 315688 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.SolrTestCaseJ4
Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001/cores/collection1
[junit4] 2> 315689 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001
[junit4] 2> 315690 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
jetty-9.3.8.v20160314
[junit4] 2> 315691 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@51c98454{/,null,AVAILABLE}
[junit4] 2> 315692 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@4ed0b631{HTTP/1.1,[http/1.1]}{127.0.0.1:54513}
[junit4] 2> 315693 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
Started @319411ms
[junit4] 2> 315693 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://solaris-vm:53673/hdfs__solaris-vm_53673__export_home_jenkins_workspace_Lucene-Solr-master-Solaris_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=54513,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001/cores}
[junit4] 2> 315693 ERROR
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 315694 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 315694 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 315694 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 315694 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-21T13:34:43.885Z
[junit4] 2> 315699 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 315699 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.SolrXmlConfig
Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001/solr.xml
[junit4] 2> 315705 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:55352/solr
[junit4] 2> 315723 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:54513_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 315730 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:54513_ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:54513_
[junit4] 2> 315732 INFO
(zkCallback-356-thread-2-processing-n:127.0.0.1:34057_) [n:127.0.0.1:34057_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 315733 INFO (zkCallback-360-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 315736 INFO
(zkCallback-366-thread-1-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 315811 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:54513_ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001/cores
[junit4] 2> 315811 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:54513_ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 315815 INFO
(OverseerStateUpdate-96975931285897220-127.0.0.1:34057_-n_0000000000)
[n:127.0.0.1:34057_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 315921 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 316836 WARN
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 316838 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 316850 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 316941 WARN
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 316943 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 316962 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 316962 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://solaris-vm:53673/solr_hdfs_home
[junit4] 2> 316962 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 316962 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-1-001/cores/collection1],
dataDir=[hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node1/data/]
[junit4] 2> 316962 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 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@71e3acdb
[junit4] 2> 316963 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node1/data/snapshot_metadata
[junit4] 2> 316972 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 316972 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 316978 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 316979 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node1/data
[junit4] 2> 317005 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node1/data/index
[junit4] 2> 317013 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 317013 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 317019 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 317019 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=14, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=97.2197265625,
floorSegmentMB=0.69140625, forceMergeDeletesPctAllowed=3.9669638217323113,
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 317050 INFO (IPC Server handler 5 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50389 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-a57cbd08-be16-4d21-beef-e70654a2beca:NORMAL:127.0.0.1:64527|RBW],
ReplicaUC[[DISK]DS-fbe16b57-9c72-4e8d-b88a-5f4dd17c8c90:NORMAL:127.0.0.1:50389|RBW]]}
size 0
[junit4] 2> 317052 INFO (IPC Server handler 7 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:64527 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-fbe16b57-9c72-4e8d-b88a-5f4dd17c8c90:NORMAL:127.0.0.1:50389|RBW],
ReplicaUC[[DISK]DS-1eb28edb-c233-45b4-aed1-56402e4dd49c:NORMAL:127.0.0.1:64527|FINALIZED]]}
size 0
[junit4] 2> 317086 WARN
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 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> 317154 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 317154 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 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> 317154 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 317167 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 317167 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 317169 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 317181 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@7a8b9196[collection1] main]
[junit4] 2> 317182 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 317183 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 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> 317183 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 317184 INFO
(searcherExecutor-1097-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@7a8b9196[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 317184 INFO
(coreLoadExecutor-1096-thread-1-processing-n:127.0.0.1:54513_)
[n:127.0.0.1:54513_ c:collection1 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 1551614906597376000
[junit4] 2> 317197 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 317197 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new
leader - try and sync
[junit4] 2> 317198 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:54513/collection1/
[junit4] 2> 317198 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 317199 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:54513/collection1/ has no replicas
[junit4] 2> 317206 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new
leader: http://127.0.0.1:54513/collection1/ shard1
[junit4] 2> 317311 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 317360 INFO
(coreZkRegister-1091-thread-1-processing-n:127.0.0.1:54513_ x:collection1
s:shard1 c:collection1 r:core_node1) [n:127.0.0.1:54513_ c:collection1 s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 317468 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 317485 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.SolrTestCaseJ4
Writing core.properties file to
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/cores/collection1
[junit4] 2> 317486 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001
[junit4] 2> 317487 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
jetty-9.3.8.v20160314
[junit4] 2> 317489 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@77921d2{/,null,AVAILABLE}
[junit4] 2> 317490 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@4643c81b{HTTP/1.1,[http/1.1]}{127.0.0.1:58922}
[junit4] 2> 317490 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.e.j.s.Server
Started @321210ms
[junit4] 2> 317491 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://solaris-vm:53673/hdfs__solaris-vm_53673__export_home_jenkins_workspace_Lucene-Solr-master-Solaris_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001_tempDir-002_jetty2,
solrconfig=solrconfig.xml, hostContext=/, hostPort=58922,
coreRootDirectory=/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/cores}
[junit4] 2> 317491 ERROR
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 317491 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
7.0.0
[junit4] 2> 317492 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 317492 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 317492 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-21T13:34:45.683Z
[junit4] 2> 317496 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 317497 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.SolrXmlConfig
Loading container configuration from
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/solr.xml
[junit4] 2> 317504 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.c.ZkContainer
Zookeeper client=127.0.0.1:55352/solr
[junit4] 2> 317521 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:58922_ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 317529 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:58922_ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:58922_
[junit4] 2> 317531 INFO (zkCallback-360-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 317532 INFO
(zkCallback-356-thread-2-processing-n:127.0.0.1:34057_) [n:127.0.0.1:34057_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 317531 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 317536 INFO
(zkCallback-372-thread-1-processing-n:127.0.0.1:58922_) [n:127.0.0.1:58922_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 317568 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:58922_ ]
o.a.s.c.CorePropertiesLocator Found 1 core definitions underneath
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/../../../../../../../../../../export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/cores
[junit4] 2> 317568 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [n:127.0.0.1:58922_ ]
o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 317573 INFO
(OverseerStateUpdate-96975931285897220-127.0.0.1:34057_-n_0000000000)
[n:127.0.0.1:34057_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 317679 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 317679 INFO
(zkCallback-372-thread-2-processing-n:127.0.0.1:58922_) [n:127.0.0.1:58922_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 318587 WARN
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 318588 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 318600 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 318698 WARN
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 318699 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.0 with uniqueid field id
[junit4] 2> 318716 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 318716 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://solaris-vm:53673/solr_hdfs_home
[junit4] 2> 318716 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 318716 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/cores/collection1],
dataDir=[hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data/]
[junit4] 2> 318717 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@71e3acdb
[junit4] 2> 318717 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data/snapshot_metadata
[junit4] 2> 318726 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 318726 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 318730 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 318732 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data
[junit4] 2> 318754 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data/index
[junit4] 2> 318761 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 318761 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 318766 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 318766 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=14, maxMergeAtOnceExplicit=29, maxMergedSegmentMB=97.2197265625,
floorSegmentMB=0.69140625, forceMergeDeletesPctAllowed=3.9669638217323113,
segmentsPerTier=49.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 318807 INFO (IPC Server handler 8 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:64527 is
added to blk_1073741827_1003{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-48319414-c43d-4d18-806d-e246910e8177:NORMAL:127.0.0.1:50389|RBW],
ReplicaUC[[DISK]DS-a57cbd08-be16-4d21-beef-e70654a2beca:NORMAL:127.0.0.1:64527|RBW]]}
size 0
[junit4] 2> 318817 INFO (IPC Server handler 1 on 53673) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:50389 is
added to blk_1073741827_1003 size 71
[junit4] 2> 318825 WARN
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 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> 318859 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 318859 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 318859 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 318872 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 318872 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 318875 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=38, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 318885 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@d735472[collection1] main]
[junit4] 2> 318887 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 318888 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 318888 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 318890 INFO
(searcherExecutor-1108-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.SolrCore [collection1] Registered new
searcher Searcher@d735472[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 318890 INFO
(coreLoadExecutor-1107-thread-1-processing-n:127.0.0.1:58922_)
[n:127.0.0.1:58922_ c:collection1 s:shard1 r:core_node2 x:collection1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1551614908386246656
[junit4] 2> 318897 INFO
(coreZkRegister-1102-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.ZkController Core needs to
recover:collection1
[junit4] 2> 318897 INFO
(updateExecutor-369-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 318897 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy Starting recovery process.
recoveringAfterStartup=true
[junit4] 2> 318898 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 318898 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy Begin buffering updates.
core=[collection1]
[junit4] 2> 318898 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.u.UpdateLog Starting to buffer updates.
HDFSUpdateLog{state=ACTIVE, tlog=null}
[junit4] 2> 318898 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy Publishing state of core
[collection1] as recovering, leader is [http://127.0.0.1:54513/collection1/]
and I am [http://127.0.0.1:58922/collection1/]
[junit4] 2> 318902 INFO
(recoveryExecutor-370-thread-1-processing-n:127.0.0.1:58922_ x:collection1
s:shard1 c:collection1 r:core_node2) [n:127.0.0.1:58922_ c:collection1 s:shard1
r:core_node2 x:collection1] o.a.s.c.RecoveryStrategy Sending prep recovery
command to [http://127.0.0.1:54513]; [WaitForState:
action=PREPRECOVERY&core=collection1&nodeName=127.0.0.1:58922_&coreNodeName=core_node2&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 318907 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node2, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true
[junit4] 2> 318907 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.h.a.PrepRecoveryOp Will wait a max of 183 seconds to see collection1
(shard1 of collection1) have state: recovering
[junit4] 2> 318907 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard1, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=down, localState=active,
nodeName=127.0.0.1:58922_, coreNodeName=core_node2,
onlyIfActiveCheckResult=false, nodeProps:
core_node2:{"core":"collection1","base_url":"http://127.0.0.1:58922","node_name":"127.0.0.1:58922_","state":"down"}
[junit4] 2> 319007 INFO
(zkCallback-366-thread-2-processing-n:127.0.0.1:54513_) [n:127.0.0.1:54513_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 319007 INFO
(zkCallback-372-thread-2-processing-n:127.0.0.1:58922_) [n:127.0.0.1:58922_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 319080 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ] o.a.s.SolrTestCaseJ4
###Starting test
[junit4] 2> 319080 INFO
(TEST-StressHdfsTest.test-seed#[D2B24768EBA4448B]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Turning on auto soft commit: 1000
[junit4] 2> 319085 INFO (qtp1462804224-2534) [n:127.0.0.1:54513_ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=2&maxShardsPerNode=1&name=delete_data_dir&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 319089 INFO
(OverseerThreadFactory-1083-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ ] o.a.s.c.CreateCollectionCmd Create collection
delete_data_dir
[junit4] 2> 319090 INFO
(OverseerThreadFactory-1083-thread-1-processing-n:127.0.0.1:34057_)
[n:127.0.0.1:34057_ ] o.a.s.c.CreateCollectionCmd Only one config set found
in zk - using it:conf1
[junit4] 2> 319302 INFO (qtp601681391-2566) [n:127.0.0.1:58922_ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=delete_data_dir_shard1_replica2&action=CREATE&numShards=1&collection=delete_data_dir&shard=shard1&wt=javabin&version=2
[junit4] 2> 319303 INFO (qtp67929762-2482) [n:127.0.0.1:34057_ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=delete_data_dir_shard1_replica1&action=CREATE&numShards=1&collection=delete_data_dir&shard=shard1&wt=javabin&version=2
[junit4] 2> 319418 INFO
(zkCallback-356-thread-3-processing-n:127.0.0.1:34057_) [n:127.0.0.1:34057_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/delete_data_dir/state.json] for collection [delete_data_dir]
has occurred - updating... (live nodes size: [3])
[junit4] 2> 319418 INFO
(zkCallback-372-thread-2-processing-n:127.0.0.1:58922_) [n:127.0.0.1:58922_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/delete_data_dir/state.json] for collection [delete_data_dir]
has occurred - updating... (live nodes size: [3])
[junit4] 2> 319910 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard1, thisCore=collection1, leaderDoesNotNeedRecovery=false, isLeader?
true, live=true, checkLive=true, currentState=recovering, localState=active,
nodeName=127.0.0.1:58922_, coreNodeName=core_node2,
onlyIfActiveCheckResult=false, nodeProps:
core_node2:{"core":"collection1","dataDir":"hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data/","base_url":"http://127.0.0.1:58922","node_name":"127.0.0.1:58922_","state":"recovering","ulogDir":"hdfs://solaris-vm:53673/solr_hdfs_home/collection1/core_node2/data/tlog"}
[junit4] 2> 319910 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.h.a.PrepRecoveryOp Waited coreNodeName: core_node2, state: recovering,
checkLive: true, onlyIfLeader: true for: 1 seconds.
[junit4] 2> 319910 INFO (qtp1462804224-2532) [n:127.0.0.1:54513_ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={nodeName=127.0.0.1:58922_&onlyIfLeaderActive=true&core=collection1&coreNodeName=core_node2&action=PREPRECOVERY&checkLive=true&state=recovering&onlyIfLeader=true&wt=javabin&version=2}
status=0 QTime=1004
[junit4] 2> 320325 WARN (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 320326 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 320327 WARN (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 320327 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.0.0
[junit4] 2> 320353 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1]
o.a.s.s.IndexSchema [delete_data_dir_shard1_replica1] Schema name=test
[junit4] 2> 320353 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2]
o.a.s.s.IndexSchema [delete_data_dir_shard1_replica2] Schema name=test
[junit4] 2> 320459 WARN (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1]
o.a.s.s.IndexSchema [delete_data_dir_shard1_replica1] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 320474 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 320489 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'delete_data_dir_shard1_replica1' using
configuration from collection delete_data_dir
[junit4] 2> 320489 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://solaris-vm:53673/solr_hdfs_home
[junit4] 2> 320489 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 320490 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.SolrCore [[delete_data_dir_shard1_replica1] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/control-001/cores/delete_data_dir_shard1_replica1],
dataDir=[hdfs://solaris-vm:53673/solr_hdfs_home/delete_data_dir/core_node1/data/]
[junit4] 2> 320490 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@71e3acdb
[junit4] 2> 320490 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/delete_data_dir/core_node1/data/snapshot_metadata
[junit4] 2> 320499 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 320499 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 320526 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 320528 WARN (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2]
o.a.s.s.IndexSchema [delete_data_dir_shard1_replica2] default search field in
schema is text. WARNING: Deprecated, please use 'df' on request instead.
[junit4] 2> 320529 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/delete_data_dir/core_node1/data
[junit4] 2> 320540 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 320552 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://solaris-vm:53673/solr_hdfs_home/delete_data_dir/core_node1/data/index
[junit4] 2> 320560 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 320560 INFO (qtp67929762-2482) [n:127.0.0.1:34057_
c:delete_data_dir s:shard1 r:core_node1 x:delete_data_dir_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[8388608] will allocate [1] slabs and use ~[8388608] bytes
[junit4] 2> 320580 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 x:delete_data_dir_shard1_replica2]
o.a.s.c.CoreContainer Creating SolrCore 'delete_data_dir_shard1_replica2' using
configuration from collection delete_data_dir
[junit4] 2> 320582 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 r:core_node2 x:delete_data_dir_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://solaris-vm:53673/solr_hdfs_home
[junit4] 2> 320582 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 r:core_node2 x:delete_data_dir_shard1_replica2]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 320582 INFO (qtp601681391-2566) [n:127.0.0.1:58922_
c:delete_data_dir s:shard1 r:core_node2 x:delete_data_dir_shard1_replica2]
o.a.s.c.SolrCore [[delete_data_dir_shard1_replica2] ] Opening new SolrCore at
[/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.StressHdfsTest_D2B24768EBA4448B-001/shard-2-001/cores/delete_data_dir_shard1_replica2],
dataDir=[hdfs://solaris-vm:53673/solr_hdfs_home/delete_data_dir/core_node2/data/]
[junit4] 2> 320582 INFO
[...truncated too long message...]
ooKeeper watch triggered, but Solr cannot talk to ZK: [KeeperErrorCode =
Session expired for /live_nodes]
[junit4] 2> 2175798 ERROR
(Thread[Thread-6990,5,TGRP-TestSolrCloudWithDelegationTokens])
[n:127.0.0.1:56964_solr ] o.a.h.s.t.d.AbstractDelegationTokenSecretManager
ExpiredTokenRemover received java.lang.InterruptedException: sleep interrupted
[junit4] 2> 2175800 INFO (jetty-launcher-4242-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@48fd6bae{/solr,null,UNAVAILABLE}
[junit4] 2> 2175803 INFO (jetty-launcher-4242-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@f7d0c4{/solr,null,UNAVAILABLE}
[junit4] 2> 2175805 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:50228 50228
[junit4] 2> 2175828 INFO (Thread-6970) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:50228 50228
[junit4] 2> 2175829 WARN (Thread-6970) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 14 /solr/aliases.json
[junit4] 2> 14 /solr/clusterprops.json
[junit4] 2> 2 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 14 /solr/clusterstate.json
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_7
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_6
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_9
[junit4] 2> 2 /solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMKeyIdRoot
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_1
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_1
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_3
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_3
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_2
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_2
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_5
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot/DK_4
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_4
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_12
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMSeqNumRoot
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_11
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot/DT_10
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 14 /solr/live_nodes
[junit4] 2> 14 /solr/collections
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMMasterKeyRoot
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2> 2
/solr/security/zkdtsm/ZKDTSMRoot/ZKDTSMTokensRoot
[junit4] 2>
[junit4] 2> 2175829 INFO
(SUITE-TestSolrCloudWithDelegationTokens-seed#[D2B24768EBA4448B]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/export/home/jenkins/workspace/Lucene-Solr-master-Solaris/solr/build/solr-core/test/J0/temp/solr.cloud.TestSolrCloudWithDelegationTokens_D2B24768EBA4448B-001
[junit4] 2> Nov 21, 2016 2:05:46 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 3 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene70): {},
docValues:{}, maxPointsInLeafNode=798, maxMBSortInHeap=7.238852504779036,
sim=RandomSimilarity(queryNorm=false): {}, locale=be, timezone=Europe/Vatican
[junit4] 2> NOTE: SunOS 5.11 amd64/Oracle Corporation 1.8.0_102
(64-bit)/cpus=3,threads=1,free=124415536,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TestXmlQParser,
ConcurrentDeleteAndCreateCollectionTest, SharedFSAutoReplicaFailoverTest,
TestMergePolicyConfig, TestConfigSetsAPI, SpatialFilterTest,
TestRandomDVFaceting, XmlUpdateRequestHandlerTest, TestJsonRequest,
HdfsSyncSliceTest, QueryElevationComponentTest, DirectoryFactoryTest,
PreAnalyzedFieldManagedSchemaCloudTest, TestSubQueryTransformerDistrib,
TestIBSimilarityFactory, SolrCoreTest, TestSort,
AddSchemaFieldsUpdateProcessorFactoryTest, TestFieldCollectionResource,
TestBinaryField, StatsReloadRaceTest, LeaderElectionTest,
XsltUpdateRequestHandlerTest, HttpSolrCallGetCoreTest, TestReqParamsAPI,
TestSolrConfigHandlerCloud, TestFunctionQuery, SuggesterFSTTest, TestSolrJ,
TestDistributedSearch, TestStressLucene, TestJmxIntegration,
SoftAutoCommitTest, BadCopyFieldTest, DistributedFacetPivotLargeTest,
ChangedSchemaMergeTest, TestPartialUpdateDeduplication, PingRequestHandlerTest,
TestDynamicFieldCollectionResource, DistributedQueryComponentOptimizationTest,
TestRequestForwarding, SimplePostToolTest, TestConfigSetImmutable,
SecurityConfHandlerTest, TestSolrCloudWithKerberosAlt, TestReplicationHandler,
TestConfigSets, DirectUpdateHandlerTest, TestRebalanceLeaders,
CollectionsAPIAsyncDistributedZkTest, ZkCLITest, ConnectionManagerTest,
TestUpdate, TestFieldCacheSanityChecker, HdfsRecoveryZkTest,
TestLeaderElectionZkExpiry, DistanceUnitsTest, SolrIndexConfigTest,
TestSchemaSimilarityResource, TestSolrDeletionPolicy1, TestFastLRUCache,
TestHdfsUpdateLog, BinaryUpdateRequestHandlerTest, TestDownShardTolerantSearch,
SOLR749Test, TestQueryWrapperFilter, DistributedQueueTest, AnalyticsQueryTest,
OverseerStatusTest, SearchHandlerTest, DOMUtilTest, MBeansHandlerTest,
TestRemoteStreaming, DataDrivenBlockJoinTest, TestCursorMarkWithoutUniqueKey,
AssignTest, DisMaxRequestHandlerTest, DistributedExpandComponentTest,
DistributedFacetPivotSmallAdvancedTest, CollectionStateFormat2Test,
MergeStrategyTest, TestSchemaNameResource,
VMParamsZkACLAndCredentialsProvidersTest,
TestDistributedStatsComponentCardinality, TestLFUCache, TestDefaultStatsCache,
TestSolrQueryResponse, SynonymTokenizerTest,
TestPerFieldSimilarityWithDefaultOverride, TestAuthenticationFramework,
TestNumericTerms32, BlobRepositoryCloudTest, CloudExitableDirectoryReaderTest,
DocExpirationUpdateProcessorFactoryTest, DateFieldTest, RollingRestartTest,
ForceLeaderTest, TestGraphMLResponseWriter, TestTolerantSearch, RecoveryZkTest,
PolyFieldTest, DistributedQueryElevationComponentTest, OutputWriterTest,
TestJsonFacetRefinement, TestHighlightDedupGrouping,
TestPostingsSolrHighlighter, TestScoreJoinQPNoScore, TestSolrXml, FullHLLTest,
BasicAuthStandaloneTest, SimpleFacetsTest, TestBlendedInfixSuggestions,
CoreAdminCreateDiscoverTest, TestSortByMinMaxFunction,
CachingDirectoryFactoryTest, SuggestComponentContextFilterQueryTest,
TestSubQueryTransformer, TestCloudInspectUtil, TestLRUStatsCache,
HighlighterTest, UniqFieldsUpdateProcessorFactoryTest, TestUninvertingReader,
AnalysisAfterCoreReloadTest, DeleteReplicaTest, TestMacroExpander,
CurrencyFieldXmlFileTest, HLLUtilTest, DocValuesMissingTest, TestFieldCache,
TestSurroundQueryParser, SortSpecParsingTest,
DeleteLastCustomShardedReplicaTest, FastVectorHighlighterTest,
TestMiniSolrCloudClusterSSL, TestSQLHandler, TestSearcherReuse, TestCSVLoader,
TestHdfsCloudBackupRestore, TestPseudoReturnFields,
OverriddenZkACLAndCredentialsProvidersTest, LeaderElectionContextKeyTest,
TestBinaryResponseWriter, TestHashPartitioner, TestBulkSchemaAPI,
HdfsBasicDistributedZkTest, TestClusterProperties,
DistributedSpellCheckComponentTest, StandardRequestHandlerTest,
TestSchemaManager, HdfsTlogReplayBufferedWhileIndexingTest,
StatelessScriptUpdateProcessorFactoryTest, HdfsChaosMonkeySafeLeaderTest,
TestGraphTermsQParserPlugin, TestSolrFieldCacheMBean,
TestCloudPseudoReturnFields, PeerSyncReplicationTest, PrimUtilsTest,
TestSweetSpotSimilarityFactory, TestImplicitCoreProperties,
TestDocBasedVersionConstraints, BasicDistributedZkTest,
UnloadDistributedZkTest, SyncSliceTest, OpenCloseCoreStressTest, OverseerTest,
ShardRoutingTest, BasicZkTest, FullSolrCloudDistribCmdsTest, ZkSolrClientTest,
ZkControllerTest, TestStressReorder, TestStressVersions,
DistributedTermsComponentTest, PeerSyncTest, ConvertedLegacyTest,
BasicFunctionalityTest, TestLazyCores, CurrencyFieldOpenExchangeTest,
TestExtendedDismaxParser, SolrRequestParserTest, SuggesterTest,
SuggesterWFSTTest, WordBreakSolrSpellCheckerTest,
SchemaVersionSpecificBehaviorTest, TestAtomicUpdateErrorCases,
TestWordDelimiterFilterFactory, QueryEqualityTest,
DirectUpdateHandlerOptimizeTest, DocValuesMultiTest, DebugComponentTest,
CacheHeaderTest, IndexBasedSpellCheckerTest, LukeRequestHandlerTest,
TestQueryUtils, TestWriterPerf, DirectSolrSpellCheckerTest,
DocumentAnalysisRequestHandlerTest, FileBasedSpellCheckerTest,
RequestHandlersTest, TestValueSourceCache, MoreLikeThisHandlerTest,
TestSolrQueryParser, LoggingHandlerTest, SolrPluginUtilsTest, ReturnFieldsTest,
TestAnalyzedSuggestions, TestPHPSerializedResponseWriter,
HighlighterConfigTest, TestQuerySenderNoQuery, TestStressRecovery,
SolrTestCaseJ4Test, TestJettySolrRunner, BaseCdcrDistributedZkTest,
CdcrBootstrapTest, DeleteInactiveReplicaTest, DeleteShardTest,
DistributedVersionInfoTest, LeaderFailoverAfterPartitionTest,
MultiThreadedOCPTest, RemoteQueryErrorTest,
SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest,
SolrCloudExampleTest, TestCloudPivotFacet, TestConfigSetsAPIExclusivity,
TestConfigSetsAPIZkFailure, TestCryptoKeys, TestDeleteCollectionOnDownNodes,
TestDistribDocBasedVersion, TestLeaderElectionWithEmptyReplica,
TestLocalFSCloudBackupRestore, TestLockTree, TestMiniSolrCloudCluster,
TestOnReconnectListenerSupport, TestRandomFlRTGCloud, TestReplicaProperties,
TestSolrCloudWithDelegationTokens]
[junit4] Completed [498/652 (3!)] on J0 in 2.73s, 8 tests, 1 failure <<<
FAILURES!
[...truncated 62850 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
