Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/355/
1 tests failed.
FAILED: org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest.test
Error Message:
There are still nodes recoverying - waited for 330 seconds
Stack Trace:
java.lang.AssertionError: There are still nodes recoverying - waited for 330
seconds
at
__randomizedtesting.SeedInfo.seed([55357071F6027176:DD614FAB58FE1C8E]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:187)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:144)
at
org.apache.solr.cloud.AbstractDistribZkTestBase.waitForRecoveriesToFinish(AbstractDistribZkTestBase.java:139)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.waitForRecoveriesToFinish(AbstractFullDistribZkTestBase.java:850)
at
org.apache.solr.cloud.TlogReplayBufferedWhileIndexingTest.test(TlogReplayBufferedWhileIndexingTest.java:72)
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:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
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:368)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 13478 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/init-core-data-001
[junit4] 2> 3502254 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.s.SolrTestCaseJ4 Using PointFields
[junit4] 2> 3502256 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=None)
[junit4] 2> 3502256 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/_y/
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 3502295 WARN
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 3502302 WARN
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3502303 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log jetty-6.1.26
[junit4] 2> 3502319 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_59919_hdfs____ge03hj/webapp
[junit4] 2> 3502824 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:59919
[junit4] 2> 3502937 WARN
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3502938 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log jetty-6.1.26
[junit4] 2> 3502952 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_38858_datanode____.szhdj7/webapp
[junit4] 2> 3503347 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:38858
[junit4] 2> 3503400 WARN
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3503402 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log jetty-6.1.26
[junit4] 2> 3503419 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.7.2-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_47934_datanode____.84me1u/webapp
[junit4] 2> 3503491 INFO (IPC Server handler 3 on 57128) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-21e23d00-5896-4b5f-ad60-1702a5988983 node
DatanodeRegistration(127.0.0.1:34809,
datanodeUuid=ea53442e-0355-4bb6-8fe1-3cbc1a5f9160, infoPort=34510,
infoSecurePort=0, ipcPort=53080,
storageInfo=lv=-56;cid=testClusterID;nsid=1669082236;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 3503492 INFO (IPC Server handler 3 on 57128) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-a951b32a-c745-4446-a74c-85cee489ddf1 node
DatanodeRegistration(127.0.0.1:34809,
datanodeUuid=ea53442e-0355-4bb6-8fe1-3cbc1a5f9160, infoPort=34510,
infoSecurePort=0, ipcPort=53080,
storageInfo=lv=-56;cid=testClusterID;nsid=1669082236;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 3503802 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:47934
[junit4] 2> 3503959 INFO (IPC Server handler 3 on 57128) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-a0d6aa4e-198a-41de-a7dd-f43dd3f47e7d node
DatanodeRegistration(127.0.0.1:57154,
datanodeUuid=b5011bf0-58a5-4039-8f79-7d24b253e826, infoPort=58262,
infoSecurePort=0, ipcPort=52269,
storageInfo=lv=-56;cid=testClusterID;nsid=1669082236;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 3503959 INFO (IPC Server handler 3 on 57128) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-5e6fb3ac-8829-44cf-9f08-fb30b5954ad2 node
DatanodeRegistration(127.0.0.1:57154,
datanodeUuid=b5011bf0-58a5-4039-8f79-7d24b253e826, infoPort=58262,
infoSecurePort=0, ipcPort=52269,
storageInfo=lv=-56;cid=testClusterID;nsid=1669082236;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 3504111 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3504115 INFO (Thread-34541) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3504115 INFO (Thread-34541) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 3504119 ERROR (Thread-34541) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 3504214 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ZkTestServer start zk server on port:52712
[junit4] 2> 3504263 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 3504267 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 3504268 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 3504270 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 3504271 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 3504272 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 3504273 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 3504274 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 3504275 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 3504276 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 3504277 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 3504402 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/control-001/cores/collection1
[junit4] 2> 3504404 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3504407 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6264e8a5{/_y,null,AVAILABLE}
[junit4] 2> 3504408 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@51619b9b{HTTP/1.1,[http/1.1]}{127.0.0.1:40041}
[junit4] 2> 3504408 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server Started @3508019ms
[junit4] 2> 3504408 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57128/hdfs__localhost_57128__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001_tempDir-002_control_data,
hostContext=/_y, hostPort=40041,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/control-001/cores}
[junit4] 2> 3504408 ERROR
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3504408 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.7.0
[junit4] 2> 3504409 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 3504409 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3504409 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-21T22:10:55.270Z
[junit4] 2> 3504413 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 3504413 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/control-001/solr.xml
[junit4] 2> 3504421 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3504422 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52712/solr
[junit4] 2> 3504456 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3504456 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:40041__y
[junit4] 2> 3504457 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.Overseer Overseer
(id=98002839468638212-127.0.0.1:40041__y-n_0000000000) starting
[junit4] 2> 3504472 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:40041__y
[junit4] 2> 3504475 INFO
(zkCallback-35141-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3504619 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/control-001/cores
[junit4] 2> 3504619 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:40041__y ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 3504623 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 3504626 INFO
(OverseerStateUpdate-98002839468638212-127.0.0.1:40041__y-n_0000000000)
[n:127.0.0.1:40041__y ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 3505641 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.7.0
[junit4] 2> 3505656 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 3505757 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 3505776 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection, trusted=true
[junit4] 2> 3505776 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57128/solr_hdfs_home
[junit4] 2> 3505776 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3505776 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3505776 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/control-001/cores/collection1],
dataDir=[hdfs://localhost:57128/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 3505777 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@76f0c55b
[junit4] 2> 3505777 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/control_collection/core_node1/data/snapshot_metadata
[junit4] 2> 3505789 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3505790 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3505790 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3505804 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3505805 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 3505825 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 3505833 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3505833 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3505833 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3505847 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3505848 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 3505865 INFO (IPC Server handler 8 on 57128) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34809 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-a0d6aa4e-198a-41de-a7dd-f43dd3f47e7d:NORMAL:127.0.0.1:57154|RBW],
ReplicaUC[[DISK]DS-a951b32a-c745-4446-a74c-85cee489ddf1:NORMAL:127.0.0.1:34809|RBW]]}
size 0
[junit4] 2> 3505866 INFO (IPC Server handler 9 on 57128) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:57154 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-a0d6aa4e-198a-41de-a7dd-f43dd3f47e7d:NORMAL:127.0.0.1:57154|RBW],
ReplicaUC[[DISK]DS-a951b32a-c745-4446-a74c-85cee489ddf1:NORMAL:127.0.0.1:34809|RBW]]}
size 0
[junit4] 2> 3505873 WARN
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 3505924 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3505925 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3505925 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 3505939 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 10000ms;
[junit4] 2> 3505939 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.CommitTracker Soft AutoCommit: if uncommited for 3000ms;
[junit4] 2> 3505941 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=47, maxMergeAtOnceExplicit=13, maxMergedSegmentMB=8.0771484375,
floorSegmentMB=2.0634765625, forceMergeDeletesPctAllowed=23.88779563212458,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 3505945 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@42041949[collection1] main]
[junit4] 2> 3505946 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 3505947 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3505947 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3505949 INFO
(searcherExecutor-15950-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@42041949[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3505950 INFO
(coreLoadExecutor-15949-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y c:control_collection x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1568045433420251136
[junit4] 2> 3505956 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 3505956 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y 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> 3505956 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:40041/_y/collection1/
[junit4] 2> 3505956 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 3505956 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:40041/_y/collection1/ has no replicas
[junit4] 2> 3505959 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 3505963 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y 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:40041/_y/collection1/ shard1
[junit4] 2> 3506114 INFO
(coreZkRegister-15942-thread-1-processing-n:127.0.0.1:40041__y x:collection1
c:control_collection) [n:127.0.0.1:40041__y c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 3506141 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 3506142 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:52712/solr
ready
[junit4] 2> 3506142 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 3506142 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 3506280 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001/cores/collection1
[junit4] 2> 3506281 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001
[junit4] 2> 3506281 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3506286 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@14fcd0c1{/_y,null,AVAILABLE}
[junit4] 2> 3506286 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@2aec048c{HTTP/1.1,[http/1.1]}{127.0.0.1:52722}
[junit4] 2> 3506287 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server Started @3509898ms
[junit4] 2> 3506287 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57128/hdfs__localhost_57128__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/_y, hostPort=52722,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001/cores}
[junit4] 2> 3506287 ERROR
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3506288 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.7.0
[junit4] 2> 3506288 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 3506288 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3506288 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-21T22:10:57.149Z
[junit4] 2> 3506291 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 3506291 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001/solr.xml
[junit4] 2> 3506298 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3506299 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52712/solr
[junit4] 2> 3506308 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:52722__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3506310 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:52722__y ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3506312 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:52722__y ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:52722__y
[junit4] 2> 3506316 INFO (zkCallback-35145-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 3506319 INFO
(zkCallback-35141-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 3506322 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 3506441 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:52722__y ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001/cores
[junit4] 2> 3506441 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:52722__y ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 3506449 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 3506451 INFO
(OverseerStateUpdate-98002839468638212-127.0.0.1:40041__y-n_0000000000)
[n:127.0.0.1:40041__y ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 3506554 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] 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> 3507465 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.7.0
[junit4] 2> 3507480 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 3507581 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 3507597 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 3507598 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57128/solr_hdfs_home
[junit4] 2> 3507598 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3507598 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3507598 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-1-001/cores/collection1],
dataDir=[hdfs://localhost:57128/solr_hdfs_home/collection1/core_node1/data/]
[junit4] 2> 3507598 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap
JMX monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@76f0c55b
[junit4] 2> 3507599 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/collection1/core_node1/data/snapshot_metadata
[junit4] 2> 3507607 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3507607 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3507607 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3507615 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 3507616 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/collection1/core_node1/data
[junit4] 2> 3507633 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/collection1/core_node1/data/index
[junit4] 2> 3507640 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3507640 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3507640 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3507650 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.s.b.BlockDirectory
Block cache on write is disabled
[junit4] 2> 3507650 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=6, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.0]
[junit4] 2> 3507663 INFO (IPC Server handler 4 on 57128) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34809 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-5e6fb3ac-8829-44cf-9f08-fb30b5954ad2:NORMAL:127.0.0.1:57154|RBW],
ReplicaUC[[DISK]DS-21e23d00-5896-4b5f-ad60-1702a5988983:NORMAL:127.0.0.1:34809|RBW]]}
size 0
[junit4] 2> 3507664 INFO (IPC Server handler 7 on 57128) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:57154 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-5e6fb3ac-8829-44cf-9f08-fb30b5954ad2:NORMAL:127.0.0.1:57154|RBW],
ReplicaUC[[DISK]DS-21e23d00-5896-4b5f-ad60-1702a5988983:NORMAL:127.0.0.1:34809|RBW]]}
size 0
[junit4] 2> 3507672 WARN
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 3507718 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3507718 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3507718 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.HdfsUpdateLog
Initializing HdfsUpdateLog: tlogDfsReplication=2
[junit4] 2> 3507729 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommited for 10000ms;
[junit4] 2> 3507729 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.CommitTracker Soft
AutoCommit: if uncommited for 3000ms;
[junit4] 2> 3507731 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy:
[TieredMergePolicy: maxMergeAtOnce=47, maxMergeAtOnceExplicit=13,
maxMergedSegmentMB=8.0771484375, floorSegmentMB=2.0634765625,
forceMergeDeletesPctAllowed=23.88779563212458, segmentsPerTier=10.0,
maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 3507737 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@41dc2671[collection1] main]
[junit4] 2> 3507738 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 3507739 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 3507739 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 3507740 INFO
(searcherExecutor-15961-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@41dc2671[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3507742 INFO
(coreLoadExecutor-15960-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y c:collection1 x:collection1] o.a.s.u.UpdateLog Could
not find max version in index or recent updates, using new clock
1568045435299299328
[junit4] 2> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y 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> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:52722/_y/collection1/
[junit4] 2> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:52722/_y/collection1/ has
no replicas
[junit4] 2> 3507749 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 3507753 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:52722/_y/collection1/ shard1
[junit4] 2> 3507856 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] 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> 3507904 INFO
(coreZkRegister-15955-thread-1-processing-n:127.0.0.1:52722__y x:collection1
c:collection1) [n:127.0.0.1:52722__y c:collection1 s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 3508008 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] 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> 3508069 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001/cores/collection1
[junit4] 2> 3508070 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001
[junit4] 2> 3508070 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3508072 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3247f728{/_y,null,AVAILABLE}
[junit4] 2> 3508072 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.AbstractConnector Started
ServerConnector@5e4da384{HTTP/1.1,[http/1.1]}{127.0.0.1:53657}
[junit4] 2> 3508073 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.e.j.s.Server Started @3511685ms
[junit4] 2> 3508074 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:57128/hdfs__localhost_57128__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.x_checkout_solr_build_solr-core_test_J2_temp_solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001_tempDir-002_jetty2,
solrconfig=solrconfig.xml, hostContext=/_y, hostPort=53657,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001/cores}
[junit4] 2> 3508074 ERROR
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3508074 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.7.0
[junit4] 2> 3508074 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port
null
[junit4] 2> 3508074 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3508074 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-05-21T22:10:58.935Z
[junit4] 2> 3508077 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 3508077 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001/solr.xml
[junit4] 2> 3508084 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with
params: socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3508085 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:52712/solr
[junit4] 2> 3508097 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:53657__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 3508099 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:53657__y ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 3508101 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:53657__y ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:53657__y
[junit4] 2> 3508103 INFO
(zkCallback-35141-thread-1-processing-n:127.0.0.1:40041__y)
[n:127.0.0.1:40041__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3508103 INFO (zkCallback-35145-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 3508103 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3508107 INFO
(zkCallback-35157-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3508159 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:53657__y ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001/cores
[junit4] 2> 3508159 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176])
[n:127.0.0.1:53657__y ] o.a.s.c.CorePropertiesLocator Cores are:
[collection1]
[junit4] 2> 3508162 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 3508165 INFO
(OverseerStateUpdate-98002839468638212-127.0.0.1:40041__y-n_0000000000)
[n:127.0.0.1:40041__y ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 3508268 INFO
(zkCallback-35151-thread-1-processing-n:127.0.0.1:52722__y)
[n:127.0.0.1:52722__y ] 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> 3508268 INFO
(zkCallback-35157-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y ] 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> 3509178 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 6.7.0
[junit4] 2> 3509209 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 3509299 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 3509318 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
collection1, trusted=true
[junit4] 2> 3509318 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:57128/solr_hdfs_home
[junit4] 2> 3509318 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3509318 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 3509318 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001/shard-2-001/cores/collection1],
dataDir=[hdfs://localhost:57128/solr_hdfs_home/collection1/core_node2/data/]
[junit4] 2> 3509319 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap
JMX monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@76f0c55b
[junit4] 2> 3509319 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/collection1/core_node2/data/snapshot_metadata
[junit4] 2> 3509327 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3509327 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3509327 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3510564 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.SolrCore
[collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4f6577a9
[junit4] 2> 3510564 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:57128/solr_hdfs_home/collection1/core_node2/data
[junit4] 2> 3510786 INFO
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.m.SolrMetricManager
Closing metric reporters for: solr.core.collection1
[junit4] 2> 3510786 ERROR
(coreLoadExecutor-15971-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y c:collection1 x:collection1] o.a.s.c.SolrCore Error
while closing
[junit4] 2> java.lang.NullPointerException
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1600)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:969)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:830)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:920)
[junit4] 2> at
org.apache.solr.core.CoreContainer.lambda$load$5(CoreContainer.java:558)
[junit4] 2> at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 3510787 ERROR
(coreContainerWorkExecutor-15967-thread-1-processing-n:127.0.0.1:53657__y)
[n:127.0.0.1:53657__y ] o.a.s.c.CoreContainer Error waiting for SolrCore to
be created
[junit4] 2> java.util.concurrent.ExecutionException:
org.apache.solr.common.SolrException: Unable to create core [collection1]
[junit4] 2> at
java.util.concurrent.FutureTask.report(FutureTask.java:122)
[junit4] 2> at
java.util.concurrent.FutureTask.get(FutureTask.java:192)
[junit4] 2> at
org.apache.solr.core.CoreContainer.lambda$load$6(CoreContainer.java:586)
[junit4] 2> at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedRunnable.run(InstrumentedExecutorService.java:176)
[junit4] 2> at
java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[junit4] 2> at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:229)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unable to
create core [collection1]
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:935)
[junit4] 2> at
org.apache.solr.core.CoreContainer.lambda$load$5(CoreContainer.java:558)
[junit4] 2> at
com.codahale.metrics.InstrumentedExecutorService$InstrumentedCallable.call(InstrumentedExecutorService.java:197)
[junit4] 2> ... 5 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: The max
direct memory is likely too low. Either increase it (by adding
-XX:MaxDirectMemorySize=<size>g -XX:+UseLargePages to your containers startup
args) or disable direct allocation using
solr.hdfs.blockcache.direct.memory.allocation=false in solrconfig.xml. If you
are putting the block cache on the heap, your java heap size might not be large
enough. Failed allocating ~16.777216 MB.
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:977)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:830)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:920)
[junit4] 2> ... 7 more
[junit4] 2> Caused by: java.lang.RuntimeException: The max direct memory
is likely too low. Either increase it (by adding
-XX:MaxDirectMemorySize=<size>g -XX:+UseLargePages to your containers startup
args) or disable direct allocation using
solr.hdfs.blockcache.direct.memory.allocation=false in solrconfig.xml. If you
are putting the block cache on the heap, your java heap size might not be large
enough. Failed allocating ~16.777216 MB.
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:312)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.getBlockDirectoryCache(HdfsDirectoryFactory.java:288)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.create(HdfsDirectoryFactory.java:228)
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:346)
[junit4] 2> at
org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:482)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:917)
[junit4] 2> ... 9 more
[junit4] 2> Caused by: java.lang.OutOfMemoryError: Direct buffer memory
[junit4] 2> at java.nio.Bits.reserveMemory(Bits.java:693)
[junit4] 2> at
java.nio.DirectByteBuffer.<init>(DirectByteBuffer.java:123)
[junit4] 2> at
java.nio.ByteBuffer.allocateDirect(ByteBuffer.java:311)
[junit4] 2> at
org.apache.solr.store.blockcache.BlockCache.<init>(BlockCache.java:75)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:310)
[junit4] 2> ... 14 more
[junit4] 2> 3511054 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.SolrTestCaseJ4 ###Starting test
[junit4] 2> 3511055 INFO
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish -
collection: collection1 failOnTimeout:true timeout (sec):330
[junit4] 2> 3841397 ERROR
(TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]) [
] o.a.s.c.Diagnostics Gave up waiting for recovery to finish. THREAD DUMP:
[junit4] 2> "IPC Client (1054263166) connection to
localhost/127.0.0.1:57128 from jenkins" Id=165055 TIMED_WAITING on
org.apache.hadoop.ipc.Client$Connection@62c2349e
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on
org.apache.hadoop.ipc.Client$Connection@62c2349e
[junit4] 2> at
org.apache.hadoop.ipc.Client$Connection.waitForWork(Client.java:933)
[junit4] 2> at
org.apache.hadoop.ipc.Client$Connection.run(Client.java:978)
[junit4] 2>
[junit4] 2> "Thread-34582" Id=165040 WAITING on java.lang.Object@70bf3c87
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on java.lang.Object@70bf3c87
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:1500)
[junit4] 2>
[junit4] 2>
"TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]-EventThread"
Id=165036 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@72ad5d5
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@72ad5d5
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:501)
[junit4] 2>
[junit4] 2>
"TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]-SendThread(127.0.0.1:52712)"
Id=165035 RUNNABLE (in native)
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> - locked sun.nio.ch.Util$3@57ad6c5e
[junit4] 2> - locked java.util.Collections$UnmodifiableSet@4ef58c9
[junit4] 2> - locked sun.nio.ch.EPollSelectorImpl@64f63ce1
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1141)
[junit4] 2>
[junit4] 2> "solr-idle-connections-evictor" Id=165031 TIMED_WAITING
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:266)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "solr-idle-connections-evictor" Id=165030 TIMED_WAITING
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:266)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2>
"org.eclipse.jetty.server.session.HashSessionManager@49c4a440Timer" Id=165026
TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5ee2e407
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@5ee2e407
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "Scheduler-1535602925" Id=165025 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6dc0788e
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6dc0788e
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "qtp2145161886-165024" Id=165024 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:392)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:563)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$800(QueuedThreadPool.java:48)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp2145161886-165023" Id=165023 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:392)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:563)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$800(QueuedThreadPool.java:48)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp2145161886-165022" Id=165022 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:392)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:563)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$800(QueuedThreadPool.java:48)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp2145161886-165021" Id=165021 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:392)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:563)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$800(QueuedThreadPool.java:48)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp2145161886-165020" Id=165020 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@4a80e8b3
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
org.eclipse.jetty.util.BlockingArrayQueue.poll(BlockingArrayQueue.java:392)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.idleJobPoll(QueuedThreadPool.java:563)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.access$800(QueuedThreadPool.java:48)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:626)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2>
"qtp2145161886-165019-acceptor-0@706ad2d5-ServerConnector@5e4da384{HTTP/1.1,[http/1.1]}{127.0.0.1:53657}"
Id=165019 RUNNABLE (in native)
[junit4] 2> at sun.nio.ch.ServerSocketChannelImpl.accept0(Native
Method)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:422)
[junit4] 2> at
sun.nio.ch.ServerSocketChannelImpl.accept(ServerSocketChannelImpl.java:250)
[junit4] 2> - locked java.lang.Object@17638225
[junit4] 2> at
org.eclipse.jetty.server.ServerConnector.accept(ServerConnector.java:373)
[junit4] 2> at
org.eclipse.jetty.server.AbstractConnector$Acceptor.run(AbstractConnector.java:601)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] 2> at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "qtp2145161886-165018" Id=165018 RUNNABLE (in native)
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> - locked sun.nio.ch.Util$3@2b90d30b
[junit4] 2> - locked java.util.Collections$UnmodifiableSet@5547efa0
[junit4] 2> - locked sun.nio.ch.EPollSelectorImpl@3d0dd
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:243)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:191)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "qtp2145161886-165017" Id=165017 RUNNABLE (in native)
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> - locked sun.nio.ch.Util$3@b7a1852
[junit4] 2> - locked java.util.Collections$UnmodifiableSet@26df8abd
[junit4] 2> - locked sun.nio.ch.EPollSelectorImpl@4c0f5b29
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:101)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.select(ManagedSelector.java:243)
[junit4] 2> at
org.eclipse.jetty.io.ManagedSelector$SelectorProducer.produce(ManagedSelector.java:191)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "searcherExecutor-15961-thread-1" Id=165014 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@525e15ea
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@525e15ea
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "Thread-34566" Id=165004 WAITING on java.lang.Object@70bf3c87
[junit4] 2> at java.lang.Object.wait(Native Method)
[junit4] 2> - waiting on java.lang.Object@70bf3c87
[junit4] 2> at java.lang.Object.wait(Object.java:502)
[junit4] 2> at
org.apache.solr.core.CloserThread.run(CoreContainer.java:1500)
[junit4] 2>
[junit4] 2>
"TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]-EventThread"
Id=165001 WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@604bc4b2
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@604bc4b2
[junit4] 2> at
java.util.concurrent.locks.LockSupport.park(LockSupport.java:175)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.await(AbstractQueuedSynchronizer.java:2039)
[junit4] 2> at
java.util.concurrent.LinkedBlockingQueue.take(LinkedBlockingQueue.java:442)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$EventThread.run(ClientCnxn.java:501)
[junit4] 2>
[junit4] 2>
"TEST-HdfsTlogReplayBufferedWhileIndexingTest.test-seed#[55357071F6027176]-SendThread(127.0.0.1:52712)"
Id=165000 RUNNABLE (in native)
[junit4] 2> at sun.nio.ch.EPollArrayWrapper.epollWait(Native Method)
[junit4] 2> at
sun.nio.ch.EPollArrayWrapper.poll(EPollArrayWrapper.java:269)
[junit4] 2> at
sun.nio.ch.EPollSelectorImpl.doSelect(EPollSelectorImpl.java:93)
[junit4] 2> at
sun.nio.ch.SelectorImpl.lockAndDoSelect(SelectorImpl.java:86)
[junit4] 2> - locked sun.nio.ch.Util$3@5214ff4d
[junit4] 2> - locked java.util.Collections$UnmodifiableSet@9f7c5d5
[junit4] 2> - locked sun.nio.ch.EPollSelectorImpl@53a72c34
[junit4] 2> at sun.nio.ch.SelectorImpl.select(SelectorImpl.java:97)
[junit4] 2> at
org.apache.zookeeper.ClientCnxnSocketNIO.doTransport(ClientCnxnSocketNIO.java:349)
[junit4] 2> at
org.apache.zookeeper.ClientCnxn$SendThread.run(ClientCnxn.java:1141)
[junit4] 2>
[junit4] 2> "solr-idle-connections-evictor" Id=164996 TIMED_WAITING
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:266)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2> "solr-idle-connections-evictor" Id=164995 TIMED_WAITING
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.solr.update.UpdateShardHandler$IdleConnectionsEvictor$1.run(UpdateShardHandler.java:266)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2>
[junit4] 2>
"org.eclipse.jetty.server.session.HashSessionManager@67eb28aaTimer" Id=164991
TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7c7a5eb7
[junit4] 2> at sun.misc.Unsafe.park(Native Method)
[junit4] 2> - waiting on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@7c7a5eb7
[junit4] 2> at
java.util.concurrent.locks.LockSupport.parkNanos(LockSupport.java:215)
[junit4] 2> at
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject.awaitNanos(AbstractQueuedSynchronizer.java:2078)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:1093)
[junit4] 2> at
java.util.concurrent.ScheduledThreadPoolExecutor$DelayedWorkQueue.take(ScheduledThreadPoolExecutor.java:809)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.getTask(ThreadPoolExecutor.java:1067)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1127)
[junit4] 2> at
java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617)
[junit4] 2> ...
[junit4] 2>
[junit4] 2> "Scheduler-896026958" Id=164990 TIMED_WAITING on
java.util.concurrent.locks.AbstractQueuedSynchronizer$ConditionObject@6859d7eb
[junit4] 2> at sun.mis
[...truncated too long message...]
s.MiniDFSCluster.shutdown(MiniDFSCluster.java:1726)
[junit4] 2> at
org.apache.hadoop.hdfs.MiniDFSCluster.shutdown(MiniDFSCluster.java:1705)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTestUtil.teardownClass(HdfsTestUtil.java:203)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest.teardownClass(HdfsTlogReplayBufferedWhileIndexingTest.java:52)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:870)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
[junit4] 2> at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
[junit4] 2> at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
[junit4] 2> at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
[junit4] 2> at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4] 2> at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java:203)
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlockManager.getTotalBlocks(BlockManager.java:3370)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.FSNamesystem.getBlocksTotal(FSNamesystem.java:5729)
[junit4] 2> ... 53 more
[junit4] 2> 3845177 INFO
(SUITE-HdfsTlogReplayBufferedWhileIndexingTest-seed#[55357071F6027176]-worker)
[ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsTlogReplayBufferedWhileIndexingTest_55357071F6027176-001
[junit4] 2> May 21, 2017 10:16:36 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 34 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1211, maxMBSortInHeap=5.227216783286775,
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=nl-NL,
timezone=America/St_Johns
[junit4] 2> NOTE: Linux 3.13.0-88-generic amd64/Oracle Corporation
1.8.0_121 (64-bit)/cpus=4,threads=2,free=329324824,total=524812288
[junit4] 2> NOTE: All tests run in this JVM: [SuggesterTest,
DistribDocExpirationUpdateProcessorTest, BadCopyFieldTest,
UnloadDistributedZkTest, SpellCheckCollatorWithCollapseTest,
TestCollationField, TestCorePropertiesReload, ShardSplitTest,
MigrateRouteKeyTest, FieldAnalysisRequestHandlerTest, TestNestedDocsSort,
QueryResultKeyTest, TestFieldCache, HardAutoCommitTest,
TestOnReconnectListenerSupport, TestSolrConfigHandlerCloud, DocValuesMultiTest,
TestDelegationWithHadoopAuth, TestFileDictionaryLookup,
TestSolrCloudWithKerberosAlt, TestFilteredDocIdSet,
PeerSyncWithIndexFingerprintCachingTest, TestSubQueryTransformerCrossCore,
SolrCoreCheckLockOnStartupTest, TestSimpleQParserPlugin,
SuggestComponentContextFilterQueryTest, RulesTest, TestUniqueKeyFieldResource,
DeleteShardTest, TestSort, OverseerRolesTest, TestDefaultStatsCache,
HdfsDirectoryTest, TestIndexingPerformance, HdfsRestartWhileUpdatingTest,
TestCloudInspectUtil, DOMUtilTest, TestConfig, CurrencyFieldXmlFileTest,
TestWriterPerf, TestHdfsCloudBackupRestore, TestMinMaxOnMultiValuedField,
TestRecovery, TestPostingsSolrHighlighter, DeleteLastCustomShardedReplicaTest,
TestShortCircuitedRequests, DirectoryFactoryTest, TestXmlQParserPlugin,
LukeRequestHandlerTest, TermVectorComponentDistributedTest,
ShowFileRequestHandlerTest, MergeStrategyTest, PingRequestHandlerTest,
ManagedSchemaRoundRobinCloudTest, TestTolerantUpdateProcessorRandomCloud,
PrimUtilsTest, CircularListTest, TestEmbeddedSolrServerSchemaAPI,
TestFieldTypeCollectionResource, CachingDirectoryFactoryTest, TestJsonRequest,
TestExactStatsCache, BasicAuthStandaloneTest, CreateCollectionCleanupTest,
TestSolrDeletionPolicy1, TestUseDocValuesAsStored, TestConfigsApi,
TestFieldCacheWithThreads, NoCacheHeaderTest, TestRestoreCore,
TestNumericTerms64, VMParamsZkACLAndCredentialsProvidersTest, UpdateParamsTest,
OpenExchangeRatesOrgProviderTest, TestPKIAuthenticationPlugin,
TestRebalanceLeaders, JavabinLoaderTest, AsyncCallRequestStatusResponseTest,
CollectionTooManyReplicasTest, ParsingFieldUpdateProcessorsTest,
TestRecoveryHdfs, TestIndexSearcher, DistributedVersionInfoTest,
SolrXmlInZkTest, TestCloudSchemaless, QueryParsingTest,
TestConfigSetsAPIZkFailure, TestNRTOpen, StatsComponentTest,
BlockJoinFacetSimpleTest, TestPayloadCheckQParserPlugin,
ClassificationUpdateProcessorFactoryTest, TestGeoJSONResponseWriter,
CloudExitableDirectoryReaderTest, TestClassicSimilarityFactory,
DistributedExpandComponentTest, UUIDUpdateProcessorFallbackTest,
TestDFRSimilarityFactory, LeaderElectionTest, TestExpandComponent,
DistributedSuggestComponentTest, ActionThrottleTest, TestMacros,
TestSerializedLuceneMatchVersion, XmlUpdateRequestHandlerTest,
TestDistributedMissingSort, MinimalSchemaTest, TestRandomCollapseQParserPlugin,
TestTolerantSearch, TestLeaderInitiatedRecoveryThread,
TestCloudPseudoReturnFields, PluginInfoTest, TestDistribDocBasedVersion,
TestReload, TestSolrXml, RecoveryZkTest, FullSolrCloudDistribCmdsTest,
ZkCLITest, AutoCommitTest, TestDistributedGrouping, TestFaceting,
TestHashPartitioner, DistributedSpellCheckComponentTest, ZkControllerTest,
TestStressReorder, DistributedTermsComponentTest, SimpleFacetsTest,
SolrCoreTest, TestGroupingSearch, QueryElevationComponentTest,
BadIndexSchemaTest, TestFunctionQuery, BasicFunctionalityTest,
DirectUpdateHandlerTest, SoftAutoCommitTest, CurrencyFieldOpenExchangeTest,
DistributedQueryElevationComponentTest, TestCoreDiscovery,
TestExtendedDismaxParser, SuggesterFSTTest, CoreAdminHandlerTest,
SolrRequestParserTest, DocValuesTest, SuggesterTSTTest, TestStressLucene,
SpatialFilterTest, SuggesterWFSTTest, TestCSVLoader, PolyFieldTest,
TestPseudoReturnFields, TestUpdate, FieldMutatingUpdateProcessorTest,
TestAtomicUpdateErrorCases, DirectUpdateHandlerOptimizeTest,
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest,
TestRemoteStreaming, DistanceFunctionTest, SolrInfoMBeanTest,
XsltUpdateRequestHandlerTest, DebugComponentTest, CacheHeaderTest,
IndexBasedSpellCheckerTest, TestSurroundQueryParser,
StandardRequestHandlerTest, DirectSolrSpellCheckerTest,
TestReversedWildcardFilterFactory, DocumentAnalysisRequestHandlerTest,
PrimitiveFieldTypeTest, TestOmitPositions, FileBasedSpellCheckerTest,
TermsComponentTest, RequestHandlersTest, TestValueSourceCache,
TermVectorComponentTest, RequiredFieldsTest, TestSolrQueryParser,
SolrPluginUtilsTest, JSONWriterTest, TestCSVResponseWriter, MBeansHandlerTest,
TestAnalyzedSuggestions, BinaryUpdateRequestHandlerTest,
TestPartialUpdateDeduplication, TestPHPSerializedResponseWriter,
CSVRequestHandlerTest, TestComponentsName, SearchHandlerTest, TestLFUCache,
PreAnalyzedFieldTest, TestSuggestSpellingConverter, DateFieldTest,
ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils, SystemInfoHandlerTest,
UUIDFieldTest, FileUtilsTest, DistributedMLTComponentTest, TestRTGBase,
CursorPagingTest, TestSimpleTrackingShardHandler, AssignTest,
BaseCdcrDistributedZkTest, CdcrBootstrapTest, CdcrRequestHandlerTest,
CollectionReloadTest, ConcurrentDeleteAndCreateCollectionTest,
DeleteReplicaTest, DistributedQueueTest, ForceLeaderTest, MultiThreadedOCPTest,
SharedFSAutoReplicaFailoverUtilsTest, SimpleCollectionCreateDeleteTest,
SolrCloudExampleTest, TestCloudJSONFacetJoinDomain, TestCollectionAPI,
TestCryptoKeys, TestDeleteCollectionOnDownNodes,
TestExclusionRuleCollectionAccess, TestLockTree, TestMiniSolrCloudCluster,
TestRequestStatusCollectionAPI, TestStressLiveNodes,
HdfsBasicDistributedZkTest, HdfsThreadLeakTest,
HdfsTlogReplayBufferedWhileIndexingTest]
[junit4] Completed [579/712 (1!)] on J2 in 352.66s, 1 test, 1 failure <<<
FAILURES!
[...truncated 43855 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
