Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/211/
3 tests failed.
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore
Error Message:
{responseHeader={status=0,QTime=33202},failure={127.0.0.1:41537_solr=org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:Error
from server at https://127.0.0.1:41537/solr: Core with name
'halfcollection_shard1_replica1' already
exists.,127.0.0.1:57336_solr=org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:Error
from server at https://127.0.0.1:57336/solr: Error CREATEing SolrCore
'halfcollection_shard2_replica1': Unable to create core
[halfcollection_shard2_replica1] Caused by: Direct buffer memory}}
Stack Trace:
java.lang.AssertionError:
{responseHeader={status=0,QTime=33202},failure={127.0.0.1:41537_solr=org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:Error
from server at https://127.0.0.1:41537/solr: Core with name
'halfcollection_shard1_replica1' already
exists.,127.0.0.1:57336_solr=org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException:Error
from server at https://127.0.0.1:57336/solr: Error CREATEing SolrCore
'halfcollection_shard2_replica1': Unable to create core
[halfcollection_shard2_replica1] Caused by: Direct buffer memory}}
at
__randomizedtesting.SeedInfo.seed([14F9FD94FEA9B12A:F83F502005350CCE]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNotNull(Assert.java:526)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore(CollectionsAPIDistributedZkTest.java:308)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testCollectionsAPI
Error Message:
Expected to see collection awhollynewcollection_0 null Last available state:
DocCollection(awhollynewcollection_0//collections/awhollynewcollection_0/state.json/2)={
"replicationFactor":"1", "shards":{ "shard1":{
"range":"80000000-d554ffff", "state":"active", "replicas":{}},
"shard2":{ "range":"d5550000-2aa9ffff", "state":"active",
"replicas":{}}, "shard3":{ "range":"2aaa0000-7fffffff",
"state":"active", "replicas":{}}}, "router":{"name":"compositeId"},
"maxShardsPerNode":"1", "autoAddReplicas":"false"}
Stack Trace:
java.lang.AssertionError: Expected to see collection awhollynewcollection_0
null
Last available state:
DocCollection(awhollynewcollection_0//collections/awhollynewcollection_0/state.json/2)={
"replicationFactor":"1",
"shards":{
"shard1":{
"range":"80000000-d554ffff",
"state":"active",
"replicas":{}},
"shard2":{
"range":"d5550000-2aa9ffff",
"state":"active",
"replicas":{}},
"shard3":{
"range":"2aaa0000-7fffffff",
"state":"active",
"replicas":{}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"1",
"autoAddReplicas":"false"}
at
__randomizedtesting.SeedInfo.seed([14F9FD94FEA9B12A:5C8C8920F89A9EBF]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:237)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testCollectionsAPI(CollectionsAPIDistributedZkTest.java:496)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets
Error Message:
KeeperErrorCode = NoNode for /collections/withconfigset2
Stack Trace:
org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode
for /collections/withconfigset2
at
__randomizedtesting.SeedInfo.seed([14F9FD94FEA9B12A:3987B2CE098D0B26]:0)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
at org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
at org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testSpecificConfigsets(CollectionsAPIDistributedZkTest.java:425)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1713)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:811)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:462)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:916)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 12787 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[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.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/init-core-data-001
[junit4] 2> 3835780 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 3835781 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001
[junit4] 2> 3835781 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 3835781 INFO (Thread-85992) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 3835781 INFO (Thread-85992) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 3835881 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:49304
[junit4] 2> 3835895 INFO (jetty-launcher-29078-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3835895 INFO (jetty-launcher-29078-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3835897 INFO (jetty-launcher-29078-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3835897 INFO (jetty-launcher-29078-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 3835903 INFO (jetty-launcher-29078-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@254828b7{/solr,null,AVAILABLE}
[junit4] 2> 3835906 INFO (jetty-launcher-29078-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2c45bc2{/solr,null,AVAILABLE}
[junit4] 2> 3835915 INFO (jetty-launcher-29078-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5b625c4a{/solr,null,AVAILABLE}
[junit4] 2> 3835917 INFO (jetty-launcher-29078-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@26f29dc1{SSL,[ssl,
http/1.1]}{127.0.0.1:41537}
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.e.j.s.Server Started @3839211ms
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=41537}
[junit4] 2> 3835918 ERROR (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3835918 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-26T14:43:02.427Z
[junit4] 2> 3835920 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3835925 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3835925 INFO (jetty-launcher-29078-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49304/solr
[junit4] 2> 3835943 INFO (jetty-launcher-29078-thread-2)
[n:127.0.0.1:41537_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:41537_solr
[junit4] 2> 3835944 INFO (jetty-launcher-29078-thread-2)
[n:127.0.0.1:41537_solr ] o.a.s.c.Overseer Overseer
(id=97004511709822979-127.0.0.1:41537_solr-n_0000000000) starting
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@25231f77{SSL,[ssl,
http/1.1]}{127.0.0.1:57336}
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.e.j.s.Server Started @3839240ms
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=57336}
[junit4] 2> 3835947 ERROR (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3835947 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-26T14:43:02.456Z
[junit4] 2> 3835948 INFO (jetty-launcher-29078-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@55b3109e{SSL,[ssl,
http/1.1]}{127.0.0.1:48321}
[junit4] 2> 3835948 INFO (jetty-launcher-29078-thread-4) [ ]
o.e.j.s.Server Started @3839241ms
[junit4] 2> 3835948 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=48321}
[junit4] 2> 3835948 ERROR (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3835948 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 3835948 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3835949 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3835949 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-26T14:43:02.458Z
[junit4] 2> 3835950 INFO (jetty-launcher-29078-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1edd833e{/solr,null,AVAILABLE}
[junit4] 2> 3835951 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3835951 INFO (jetty-launcher-29078-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@5c8a2996{SSL,[ssl,
http/1.1]}{127.0.0.1:42093}
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.e.j.s.Server Started @3839245ms
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=42093}
[junit4] 2> 3835952 ERROR (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
6.4.0
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 3835952 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-11-26T14:43:02.461Z
[junit4] 2> 3835954 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3835955 INFO (jetty-launcher-29078-thread-2)
[n:127.0.0.1:41537_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:41537_solr
[junit4] 2> 3835957 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3835958 INFO (jetty-launcher-29078-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49304/solr
[junit4] 2> 3835959 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 3835962 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x158a116e6130005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 3835966 INFO
(OverseerStateUpdate-97004511709822979-127.0.0.1:41537_solr-n_0000000000)
[n:127.0.0.1:41537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3835967 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3835967 INFO (jetty-launcher-29078-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49304/solr
[junit4] 2> 3835973 INFO (jetty-launcher-29078-thread-3)
[n:127.0.0.1:42093_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3835973 INFO (jetty-launcher-29078-thread-1)
[n:127.0.0.1:57336_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 3835976 INFO (jetty-launcher-29078-thread-3)
[n:127.0.0.1:42093_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:42093_solr
[junit4] 2> 3835976 INFO (jetty-launcher-29078-thread-1)
[n:127.0.0.1:57336_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57336_solr
[junit4] 2> 3835977 INFO
(zkCallback-29084-thread-1-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 3835988 INFO
(zkCallback-29096-thread-1-processing-n:127.0.0.1:42093_solr)
[n:127.0.0.1:42093_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (2)
[junit4] 2> 3835994 INFO
(zkCallback-29096-thread-1-processing-n:127.0.0.1:42093_solr)
[n:127.0.0.1:42093_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3835994 INFO
(zkCallback-29084-thread-1-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 3836000 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 3836001 INFO (jetty-launcher-29078-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:49304/solr
[junit4] 2> 3836019 INFO
(zkCallback-29095-thread-1-processing-n:127.0.0.1:57336_solr)
[n:127.0.0.1:57336_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (1) -> (3)
[junit4] 2> 3836028 INFO (jetty-launcher-29078-thread-2)
[n:127.0.0.1:41537_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node2/.
[junit4] 2> 3836032 INFO (jetty-launcher-29078-thread-4)
[n:127.0.0.1:48321_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 3836035 INFO (jetty-launcher-29078-thread-4)
[n:127.0.0.1:48321_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:48321_solr
[junit4] 2> 3836035 INFO
(zkCallback-29096-thread-1-processing-n:127.0.0.1:42093_solr)
[n:127.0.0.1:42093_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3836035 INFO
(zkCallback-29084-thread-1-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3836035 INFO
(zkCallback-29095-thread-2-processing-n:127.0.0.1:57336_solr)
[n:127.0.0.1:57336_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3836038 INFO
(zkCallback-29102-thread-1-processing-n:127.0.0.1:48321_solr)
[n:127.0.0.1:48321_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 3836054 INFO (jetty-launcher-29078-thread-1)
[n:127.0.0.1:57336_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node1/.
[junit4] 2> 3836063 INFO (jetty-launcher-29078-thread-3)
[n:127.0.0.1:42093_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node3/.
[junit4] 2> 3836089 INFO (jetty-launcher-29078-thread-4)
[n:127.0.0.1:48321_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node4/.
[junit4] 2> 3836098 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3836098 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:49304/solr ready
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 3836131 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 3836134 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3836135 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 3836145 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-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_42355_hdfs____71vbzz/webapp
[junit4] 2> 3836499 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:42355
[junit4] 2> 3836624 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3836625 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 3836635 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-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_39903_datanode____.hgla2r/webapp
[junit4] 2> 3837007 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:39903
[junit4] 2> 3837054 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 3837055 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 3837067 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-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_55745_datanode____.vxrvsx/webapp
[junit4] 2> 3837114 INFO (IPC Server handler 3 on 52503) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-26128d13-b7de-4f61-a8f7-c9125d4b065a node
DatanodeRegistration(127.0.0.1:57223,
datanodeUuid=ab857848-4ec3-4df2-bce4-d9d041cce4f6, infoPort=58350,
infoSecurePort=0, ipcPort=39577,
storageInfo=lv=-56;cid=testClusterID;nsid=1999193985;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 3837114 INFO (IPC Server handler 3 on 52503) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-3050d3fe-72c6-4f22-85e6-074d44a9bda1 node
DatanodeRegistration(127.0.0.1:57223,
datanodeUuid=ab857848-4ec3-4df2-bce4-d9d041cce4f6, infoPort=58350,
infoSecurePort=0, ipcPort=39577,
storageInfo=lv=-56;cid=testClusterID;nsid=1999193985;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 3837416 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:55745
[junit4] 2> 3837545 INFO (IPC Server handler 8 on 52503) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-0fec537e-a63d-40e3-afbf-de964ecd7c31 node
DatanodeRegistration(127.0.0.1:43209,
datanodeUuid=57294224-b3b5-43d3-ade6-8181f797d604, infoPort=58324,
infoSecurePort=0, ipcPort=41559,
storageInfo=lv=-56;cid=testClusterID;nsid=1999193985;c=0), blocks: 0,
hasStaleStorage: true, processing time: 0 msecs
[junit4] 2> 3837546 INFO (IPC Server handler 8 on 52503) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-ff44f48e-2492-43c6-ba26-5f827e47d214 node
DatanodeRegistration(127.0.0.1:43209,
datanodeUuid=57294224-b3b5-43d3-ade6-8181f797d604, infoPort=58324,
infoSecurePort=0, ipcPort=41559,
storageInfo=lv=-56;cid=testClusterID;nsid=1999193985;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 3837646 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[14F9FD94FEA9B12A])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet
[junit4] 2> 3837648 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[14F9FD94FEA9B12A])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3837709 INFO (qtp2053164388-195661) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:57336/solr,https://127.0.0.1:48321/solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 3837711 INFO
(OverseerThreadFactory-12695-thread-1-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.CreateCollectionCmd Create collection
nodeset_collection
[junit4] 2> 3837711 WARN
(OverseerThreadFactory-12695-thread-1-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.CreateCollectionCmd It is unusual to
create a collection (nodeset_collection) without cores.
[junit4] 2> 3837819 INFO (qtp2053164388-195661) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 30 seconds. Check all shard replicas
[junit4] 2> 3837819 INFO (qtp2053164388-195661) [n:127.0.0.1:41537_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf&name=nodeset_collection&action=CREATE&numShards=2&createNodeSet=https://127.0.0.1:57336/solr,https://127.0.0.1:48321/solr&wt=javabin&version=2}
status=0 QTime=110
[junit4] 2> 3837820 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[14F9FD94FEA9B12A])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet
[junit4] 2> 3837889 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[14F9FD94FEA9B12A])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateShouldFailOnExistingCore
[junit4] 2> 3837890 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[14F9FD94FEA9B12A])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 3837892 INFO (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=nodeset_collection&action=DELETE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 3837895 INFO
(OverseerCollectionConfigSetProcessor-97004511709822979-127.0.0.1:41537_solr-n_0000000000)
[n:127.0.0.1:41537_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 3837895 INFO
(OverseerThreadFactory-12695-thread-2-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 3838598 INFO (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=nodeset_collection&action=DELETE&wt=javabin&version=2} status=0
QTime=706
[junit4] 2> 3838603 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CoreAdminOperation core create command
dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2
[junit4] 2> 3838604 INFO
(OverseerStateUpdate-97004511709822979-127.0.0.1:41537_solr-n_0000000000)
[n:127.0.0.1:41537_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 3839621 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 3839627 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema
[halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 3839630 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3839630 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using
configuration from collection halfcollectionblocker
[junit4] 2> 3839635 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52503/data
[junit4] 2> 3839635 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3839635 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.SolrCore [[halfcollection_shard1_replica1] ] 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.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node2/halfcollection_shard1_replica1],
dataDir=[hdfs://localhost:52503/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003/]
[junit4] 2> 3839635 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003/snapshot_metadata
[junit4] 2> 3839641 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3839641 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3839641 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3839654 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3839655 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003
[junit4] 2> 3839667 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003/index
[junit4] 2> 3839675 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3839675 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3839675 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3839687 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3839706 INFO (IPC Server handler 5 on 52503) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43209 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-26128d13-b7de-4f61-a8f7-c9125d4b065a:NORMAL:127.0.0.1:57223|RBW],
ReplicaUC[[DISK]DS-0fec537e-a63d-40e3-afbf-de964ecd7c31:NORMAL:127.0.0.1:43209|FINALIZED]]}
size 0
[junit4] 2> 3839706 INFO (IPC Server handler 6 on 52503) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:57223 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-26128d13-b7de-4f61-a8f7-c9125d4b065a:NORMAL:127.0.0.1:57223|RBW],
ReplicaUC[[DISK]DS-0fec537e-a63d-40e3-afbf-de964ecd7c31:NORMAL:127.0.0.1:43209|FINALIZED]]}
size 0
[junit4] 2> 3839719 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3839719 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 3839719 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3839735 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 3839735 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 3839740 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@157d9e23[halfcollection_shard1_replica1] main]
[junit4] 2> 3839741 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 3839741 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 3839741 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 3839742 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1552072191509528576
[junit4] 2> 3839742 INFO
(searcherExecutor-12716-thread-1-processing-n:127.0.0.1:41537_solr
x:halfcollection_shard1_replica1 s:shard1 c:halfcollectionblocker r:core_node1)
[n:127.0.0.1:41537_solr c:halfcollectionblocker s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.SolrCore
[halfcollection_shard1_replica1] Registered new searcher
Searcher@157d9e23[halfcollection_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3839748 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 3839748 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 3839748 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:41537/solr/halfcollection_shard1_replica1/
[junit4] 2> 3839749 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 3839749 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy
https://127.0.0.1:41537/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 3839752 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:41537/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 3839896 INFO
(OverseerCollectionConfigSetProcessor-97004511709822979-127.0.0.1:41537_solr-n_0000000000)
[n:127.0.0.1:41537_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 3839903 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 3839904 INFO (qtp2053164388-195659) [n:127.0.0.1:41537_solr
c:halfcollectionblocker s:shard1 r:core_node1 x:halfcollection_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2}
status=0 QTime=1301
[junit4] 2> 3839961 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
] o.a.s.h.a.CoreAdminOperation core create command
dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2
[junit4] 2> 3839962 INFO
(OverseerStateUpdate-97004511709822979-127.0.0.1:41537_solr-n_0000000000)
[n:127.0.0.1:41537_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 3840968 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 3840974 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 3840991 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3840992 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using
configuration from collection halfcollectionblocker2
[junit4] 2> 3840992 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:52503/data
[junit4] 2> 3840992 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos
Authentication disabled
[junit4] 2> 3840992 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.SolrCore
[[halfcollection_shard1_replica1] ] 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.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node1/halfcollection_shard1_replica1],
dataDir=[hdfs://localhost:52503/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004/]
[junit4] 2> 3840993 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004/snapshot_metadata
[junit4] 2> 3840997 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Number of slabs
of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 3840998 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Block cache
target memory usage, slab size of [16777216] will allocate [1] slabs and use
~[16777216] bytes
[junit4] 2> 3840998 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Creating new
single instance HDFS BlockCache
[junit4] 2> 3841008 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.s.b.BlockDirectory Block cache on write
is disabled
[junit4] 2> 3841009 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004
[junit4] 2> 3841022 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory creating
directory factory for path
hdfs://localhost:52503/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004/index
[junit4] 2> 3841027 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Number of slabs
of block cache [1] with direct memory allocation set to [true]
[junit4] 2> 3841027 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Block cache
target memory usage, slab size of [16777216] will allocate [1] slabs and use
~[16777216] bytes
[junit4] 2> 3841027 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.HdfsDirectoryFactory Creating new
single instance HDFS BlockCache
[junit4] 2> 3841035 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.s.b.BlockDirectory Block cache on write
is disabled
[junit4] 2> 3841075 INFO (IPC Server handler 6 on 52503) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:57223 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-ff44f48e-2492-43c6-ba26-5f827e47d214:NORMAL:127.0.0.1:43209|RBW],
ReplicaUC[[DISK]DS-3050d3fe-72c6-4f22-85e6-074d44a9bda1:NORMAL:127.0.0.1:57223|RBW]]}
size 0
[junit4] 2> 3841076 INFO (IPC Server handler 7 on 52503) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:43209 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-ff44f48e-2492-43c6-ba26-5f827e47d214:NORMAL:127.0.0.1:43209|RBW],
ReplicaUC[[DISK]DS-3050d3fe-72c6-4f22-85e6-074d44a9bda1:NORMAL:127.0.0.1:57223|RBW]]}
size 0
[junit4] 2> 3841103 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.UpdateHandler Using UpdateLog
implementation: org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 3841103 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Initializing UpdateLog:
dataDir=null defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
numVersionBuckets=65536
[junit4] 2> 3841103 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.HdfsUpdateLog Initializing
HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 3841110 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Hard AutoCommit:
disabled
[junit4] 2> 3841110 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.CommitTracker Soft AutoCommit:
disabled
[junit4] 2> 3841116 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@52fc1b5c[halfcollection_shard1_replica1] main]
[junit4] 2> 3841117 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Configured
ZooKeeperStorageIO with znodeBase: /configs/conf
[junit4] 2> 3841118 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.r.ManagedResourceStorage Loaded null at
path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 3841118 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.h.ReplicationHandler Commits will be
reserved for 10000
[junit4] 2> 3841118 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog Could not find max version
in index or recent updates, using new clock 1552072192952369152
[junit4] 2> 3841119 INFO
(searcherExecutor-12721-thread-1-processing-n:127.0.0.1:57336_solr
x:halfcollection_shard1_replica1 s:shard1 c:halfcollectionblocker2
r:core_node1) [n:127.0.0.1:57336_solr c:halfcollectionblocker2 s:shard1
r:core_node1 x:halfcollection_shard1_replica1] o.a.s.c.SolrCore
[halfcollection_shard1_replica1] Registered new searcher
Searcher@52fc1b5c[halfcollection_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 3841123 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext Enough
replicas found to continue.
[junit4] 2> 3841123 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I may be
the new leader - try and sync
[junit4] 2> 3841123 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:57336/solr/halfcollection_shard1_replica1/
[junit4] 2> 3841123 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 3841123 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.SyncStrategy
https://127.0.0.1:57336/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 3841125 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.ShardLeaderElectionContext I am the
new leader: https://127.0.0.1:57336/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 3841277 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.c.ZkController I am the leader, no
recovery necessary
[junit4] 2> 3841278 INFO (qtp1777769560-195642) [n:127.0.0.1:57336_solr
c:halfcollectionblocker2 s:shard1 r:core_node1
x:halfcollection_shard1_replica1] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/cores
params={dataDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J2/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-004&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2}
status=0 QTime=1317
[junit4] 2> 3841280 INFO (qtp2053164388-195663) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=halfcollection&action=CREATE&numShards=2&createNodeSet=127.0.0.1:41537_solr,127.0.0.1:57336_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 3841282 INFO
(OverseerThreadFactory-12695-thread-3-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.CreateCollectionCmd Create collection
halfcollection
[junit4] 2> 3841497 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard2_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard2&wt=javabin&version=2
[junit4] 2> 3841500 INFO (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard1_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard1&wt=javabin&version=2
[junit4] 2> 3841500 WARN (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 3841500 ERROR (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Core with
name 'halfcollection_shard1_replica1' already exists.
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:764)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:377)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:365)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:156)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:664)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:445)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[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> 3841501 INFO (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&newCollection=true&name=halfcollection_shard1_replica1&action=CREATE&numShards=2&collection=halfcollection&shard=shard1&wt=javabin&version=2}
status=500 QTime=1
[junit4] 2> 3841501 ERROR (qtp2053164388-195662) [n:127.0.0.1:41537_solr
] o.a.s.s.HttpSolrCall null:org.apache.solr.common.SolrException: Core with
name 'halfcollection_shard1_replica1' already exists.
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:764)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:377)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:365)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:156)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:664)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:445)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[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> 3841502 ERROR
(OverseerThreadFactory-12695-thread-3-processing-n:127.0.0.1:41537_solr)
[n:127.0.0.1:41537_solr ] o.a.s.c.OverseerCollectionMessageHandler Error
from shard: https://127.0.0.1:41537/solr
[junit4] 2>
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at https://127.0.0.1:41537/solr: Core with name
'halfcollection_shard1_replica1' already exists.
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:593)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:262)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:251)
[junit4] 2> at
org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
[junit4] 2> at
org.apache.solr.handler.component.HttpShardHandler.lambda$submit$0(HttpShardHandler.java:196)
[junit4] 2> at
java.util.concurrent.FutureTask.run(FutureTask.java:266)
[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> 3841603 INFO
(zkCallback-29095-thread-2-processing-n:127.0.0.1:57336_solr)
[n:127.0.0.1:57336_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/halfcollection/state.json] for collection [halfcollection]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 3842505 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 x:halfcollection_shard2_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 3842511 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 x:halfcollection_shard2_replica1]
o.a.s.s.IndexSchema [halfcollection_shard2_replica1] Schema name=minimal
[junit4] 2> 3842513 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 x:halfcollection_shard2_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 3842514 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 x:halfcollection_shard2_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard2_replica1' using
configuration from collection halfcollection
[junit4] 2> 3842515 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:52503/data
[junit4] 2> 3842515 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 3842515 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.SolrCore [[halfcollection_shard2_replica1] ] 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.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001/tempDir-001/node1/halfcollection_shard2_replica1],
dataDir=[hdfs://localhost:52503/data/halfcollection/core_node1/data/]
[junit4] 2> 3842515 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollection/core_node1/data/snapshot_metadata
[junit4] 2> 3842520 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3842520 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3842520 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3842530 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 3842531 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollection/core_node1/data
[junit4] 2> 3842547 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:52503/data/halfcollection/core_node1/data/index
[junit4] 2> 3842552 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Number of slabs of block cache [1] with direct
memory allocation set to [true]
[junit4] 2> 3842552 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Block cache target memory usage, slab size of
[16777216] will allocate [1] slabs and use ~[16777216] bytes
[junit4] 2> 3842553 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.HdfsDirectoryFactory Creating new single instance HDFS BlockCache
[junit4] 2> 3843769 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.SolrCore [halfcollection_shard2_replica1] CLOSING SolrCore
org.apache.solr.core.SolrCore@5e95eff8
[junit4] 2> 3843770 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.s.h.HdfsDirectory Closing hdfs directory
hdfs://localhost:52503/data/halfcollection/core_node1/data/snapshot_metadata
[junit4] 2> 3843770 INFO (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.s.h.HdfsDirectory Closing hdfs directory
hdfs://localhost:52503/data/halfcollection/core_node1/data
[junit4] 2> 3843770 ERROR (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.c.CoreContainer Error creating core [halfcollection_shard2_replica1]: 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> 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:900)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:775)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:842)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:779)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:377)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:365)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:156)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:664)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:445)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.ssl.SslConnection.onFillable(SslConnection.java:202)
[junit4] 2> at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] 2> at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] 2> at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] 2> at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[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> 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:304)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.getBlockDirectoryCache(HdfsDirectoryFactory.java:280)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.create(HdfsDirectoryFactory.java:220)
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:346)
[junit4] 2> at
org.apache.solr.update.SolrIndexWriter.create(SolrIndexWriter.java:66)
[junit4] 2> at
org.apache.solr.core.SolrCore.initIndex(SolrCore.java:673)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:847)
[junit4] 2> ... 39 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:68)
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.createBlockCache(HdfsDirectoryFactory.java:302)
[junit4] 2> ... 45 more
[junit4] 2> 3843772 ERROR (qtp1777769560-195641) [n:127.0.0.1:57336_solr
c:halfcollection s:shard2 r:core_node1 x:halfcollection_shard2_replica1]
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Error
CREATEing SolrCore 'halfcollection_shard2_replica1': Unable to create core
[halfcollection_shard2_replica1] Caused by: Direct buffer memory
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:813)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.lambda$static$0(CoreAdminOperation.java:88)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminOperation.execute(CoreAdminOperation.java:377)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler$CallInfo.call(CoreAdminHandler.java:365)
[junit4] 2> at
org.apache.solr.handler.admin.CoreAdminHandler.handleRequestBody(CoreAdminHandler.java:156)
[junit4] 2> at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:152)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.handleAdminRequest(HttpSolrCall.java:664)
[junit4] 2> at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:445)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:303)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:254)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:110)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] 2> at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] 2> at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] 2> at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] 2> at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] 2> at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] 2> at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] 2> at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] 2> at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] 2> at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] 2> at org.eclipse.jetty.io.AbstractConnection$ReadCall
[...truncated too long message...]
r.java:194)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.updateJmxCache(MetricsSourceAdapter.java:172)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMBeanInfo(MetricsSourceAdapter.java:151)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.exclusiveUnregisterMBean(DefaultMBeanServerInterceptor.java:430)
[junit4] 2> at
com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.unregisterMBean(DefaultMBeanServerInterceptor.java:415)
[junit4] 2> at
com.sun.jmx.mbeanserver.JmxMBeanServer.unregisterMBean(JmxMBeanServer.java:546)
[junit4] 2> at
org.apache.hadoop.metrics2.util.MBeans.unregister(MBeans.java:81)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stopMBeans(MetricsSourceAdapter.java:226)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.stop(MetricsSourceAdapter.java:211)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stopSources(MetricsSystemImpl.java:463)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.stop(MetricsSystemImpl.java:213)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSystemImpl.shutdown(MetricsSystemImpl.java:594)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdownInstance(DefaultMetricsSystem.java:72)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.DefaultMetricsSystem.shutdown(DefaultMetricsSystem.java:68)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.metrics.NameNodeMetrics.shutdown(NameNodeMetrics.java:171)
[junit4] 2> at
org.apache.hadoop.hdfs.server.namenode.NameNode.stop(NameNode.java:872)
[junit4] 2> at
org.apache.hadoop.hdfs.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:198)
[junit4] 2> at
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.teardownClass(HdfsCollectionsAPIDistributedZkTest.java:52)
[junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native
Method)
[junit4] 2> at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] 2> at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] 2> at java.lang.reflect.Method.invoke(Method.java:498)
[junit4] 2> at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java: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:367)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Caused by: java.lang.NullPointerException
[junit4] 2> at
org.apache.hadoop.hdfs.server.blockmanagement.BlocksMap.size(BlocksMap.java: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> 3991457 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-worker) [
] o.a.s.c.ZkTestServer connecting to 127.0.0.1:49304 49304
[junit4] 2> 3991457 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[14F9FD94FEA9B12A]-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.HdfsCollectionsAPIDistributedZkTest_14F9FD94FEA9B12A-001
[junit4] 2> Nov 26, 2016 2:45:37 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 35 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene62,
sim=RandomSimilarity(queryNorm=false,coord=yes): {}, locale=sr-Latn-RS,
timezone=US/Arizona
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=2,free=372174848,total=515899392
[junit4] 2> NOTE: All tests run in this JVM: [TestScoreJoinQPNoScore,
TestCloudInspectUtil, MinimalSchemaTest, ConnectionManagerTest,
CollectionStateFormat2Test, TestSmileRequest,
TestLMJelinekMercerSimilarityFactory, TestTrackingShardHandlerFactory,
HdfsTlogReplayBufferedWhileIndexingTest, ShardSplitTest, SuggesterTest,
CoreAdminCreateDiscoverTest, TestLeaderElectionWithEmptyReplica,
StatsReloadRaceTest, CurrencyFieldXmlFileTest, HttpPartitionTest,
PluginInfoTest, TestPushWriter, TestPhraseSuggestions,
TestDFISimilarityFactory, SolrXmlInZkTest, SolrCoreCheckLockOnStartupTest,
TestConfigSetProperties, TestSubQueryTransformerCrossCore, InfoHandlerTest,
CoreAdminHandlerTest, TestSSLRandomization, TestReplicaProperties,
TestRandomFlRTGCloud, RankQueryTest, TestCryptoKeys, TimeZoneUtilsTest,
TestIndexingPerformance, PeerSyncWithIndexFingerprintCachingTest,
TestTolerantUpdateProcessorRandomCloud,
TestOverriddenPrefixQueryForCustomFieldType, ZkStateWriterTest,
TestConfigReload, TestConfigSetsAPI, DistribCursorPagingTest,
TestDownShardTolerantSearch, TestSolrCoreSnapshots,
TestPostingsSolrHighlighter, TestSchemaNameResource,
TestAuthorizationFramework, LeaderFailureAfterFreshStartTest,
HdfsNNFailoverTest, TestSolrQueryParser, TestRecovery, CheckHdfsIndexTest,
StatsComponentTest, RequestHandlersTest, TestGraphTermsQParserPlugin,
TestSortByMinMaxFunction, TestSolrCloudWithDelegationTokens, TestDistribIDF,
CdcrRequestHandlerTest, SpatialHeatmapFacetsTest, TestConfig,
OverseerRolesTest, TestFieldResource, TestXmlQParser,
DocExpirationUpdateProcessorFactoryTest, TestUseDocValuesAsStored,
TestBackupRepositoryFactory, StressHdfsTest, SuggesterTSTTest,
TestAnalyzedSuggestions, RulesTest, TestSchemaVersionResource,
TestReqParamsAPI, TestUtils, SpellPossibilityIteratorTest, PrimUtilsTest,
TestDistributedMissingSort, BasicDistributedZk2Test, CdcrBootstrapTest,
PreAnalyzedFieldTest, CloudMLTQParserTest, HdfsChaosMonkeyNothingIsSafeTest,
TestJmxMonitoredMap, NoCacheHeaderTest, FieldMutatingUpdateProcessorTest,
TestUnifiedSolrHighlighter, TestFieldCacheWithThreads,
TolerantUpdateProcessorTest, ChangedSchemaMergeTest, TestReloadAndDeleteDocs,
TestPerFieldSimilarityWithDefaultOverride, PingRequestHandlerTest, FullHLLTest,
TestCloudRecovery, DebugComponentTest, UnloadDistributedZkTest,
TestSolrDynamicMBean, TestReloadDeadlock, TestNumericTerms64,
OverriddenZkACLAndCredentialsProvidersTest, BlockJoinFacetRandomTest,
TestHdfsUpdateLog, UpdateParamsTest, XmlUpdateRequestHandlerTest,
StatelessScriptUpdateProcessorFactoryTest, ConfigSetsAPITest,
DeleteInactiveReplicaTest, DeleteLastCustomShardedReplicaTest, DeleteNodeTest,
DeleteReplicaTest, DistributedQueueTest, LeaderElectionContextKeyTest,
LeaderFailoverAfterPartitionTest, OutOfBoxZkACLAndCredentialsProvidersTest,
PeerSyncReplicationTest, RemoteQueryErrorTest, RestartWhileUpdatingTest,
SaslZkACLProviderTest, SharedFSAutoReplicaFailoverTest, TestClusterProperties,
TestCollectionAPI, TestLeaderElectionZkExpiry,
TestLeaderInitiatedRecoveryThread, TestMiniSolrCloudClusterSSL,
TestOnReconnectListenerSupport, TestShortCircuitedRequests,
TestSolrCloudWithKerberosAlt, TestStressLiveNodes,
VMParamsZkACLAndCredentialsProvidersTest, HdfsBasicDistributedZk2Test,
HdfsChaosMonkeySafeLeaderTest, HdfsCollectionsAPIDistributedZkTest]
[junit4] Completed [525/657 (1!)] on J2 in 165.59s, 20 tests, 2 failures, 1
error <<< FAILURES!
[...truncated 61167 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
