Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.x/235/
2 tests failed.
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([17C0F5DD0EEBFFF0:3ABEBA87F9CF45FC]: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)
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/5)={
"replicationFactor":"3", "shards":{ "shard1":{
"range":"80000000-ffffffff", "state":"active", "replicas":{}},
"shard2":{ "range":"0-7fffffff", "state":"active",
"replicas":{}}}, "router":{"name":"compositeId"}, "maxShardsPerNode":"2",
"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/5)={
"replicationFactor":"3",
"shards":{
"shard1":{
"range":"80000000-ffffffff",
"state":"active",
"replicas":{}},
"shard2":{
"range":"0-7fffffff",
"state":"active",
"replicas":{}}},
"router":{"name":"compositeId"},
"maxShardsPerNode":"2",
"autoAddReplicas":"false"}
at
__randomizedtesting.SeedInfo.seed([17C0F5DD0EEBFFF0:5FB5816908D8D065]:0)
at org.junit.Assert.fail(Assert.java:93)
at
org.apache.solr.cloud.SolrCloudTestCase.waitForState(SolrCloudTestCase.java:265)
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)
Build Log:
[...truncated 12139 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/init-core-data-001
[junit4] 2> 2510719 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 2510720 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001
[junit4] 2> 2510720 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2510720 INFO (Thread-166415) [ ] o.a.s.c.ZkTestServer
client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2510720 INFO (Thread-166415) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 2510821 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.c.ZkTestServer start zk server on port:48873
[junit4] 2> 2510919 INFO (jetty-launcher-1113-thread-1) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2510929 INFO (jetty-launcher-1113-thread-2) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2510929 INFO (jetty-launcher-1113-thread-4) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2510931 INFO (jetty-launcher-1113-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@20b81ff2{/solr,null,AVAILABLE}
[junit4] 2> 2510932 INFO (jetty-launcher-1113-thread-3) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 2510934 INFO (jetty-launcher-1113-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@13369779{/solr,null,AVAILABLE}
[junit4] 2> 2510944 INFO (jetty-launcher-1113-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@561b9683{/solr,null,AVAILABLE}
[junit4] 2> 2511003 INFO (jetty-launcher-1113-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2056d7d1{SSL,[ssl,
http/1.1]}{127.0.0.1:45549}
[junit4] 2> 2511003 INFO (jetty-launcher-1113-thread-3) [ ]
o.e.j.s.Server Started @2515192ms
[junit4] 2> 2511004 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45549}
[junit4] 2> 2511004 ERROR (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2511009 INFO (jetty-launcher-1113-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@45e1d8b6{SSL,[ssl,
http/1.1]}{127.0.0.1:43166}
[junit4] 2> 2511092 INFO (jetty-launcher-1113-thread-4) [ ]
o.e.j.s.Server Started @2515280ms
[junit4] 2> 2511092 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=43166}
[junit4] 2> 2511092 ERROR (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2511092 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 2511092 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2511093 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2511093 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-23T19:06:32.068Z
[junit4] 2> 2511009 INFO (jetty-launcher-1113-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@549af127{SSL,[ssl,
http/1.1]}{127.0.0.1:49378}
[junit4] 2> 2511093 INFO (jetty-launcher-1113-thread-1) [ ]
o.e.j.s.Server Started @2515282ms
[junit4] 2> 2511093 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=49378}
[junit4] 2> 2511008 INFO (jetty-launcher-1113-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@989ac47{/solr,null,AVAILABLE}
[junit4] 2> 2511098 ERROR (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2511098 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 2511098 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2511098 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2511098 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-23T19:06:32.073Z
[junit4] 2> 2511100 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 2511100 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2511100 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2511100 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-23T19:06:32.075Z
[junit4] 2> 2511101 INFO (jetty-launcher-1113-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@641c2175{SSL,[ssl,
http/1.1]}{127.0.0.1:37212}
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.e.j.s.Server Started @2515290ms
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37212}
[junit4] 2> 2511102 ERROR (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
6.4.0
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2511102 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-12-23T19:06:32.077Z
[junit4] 2> 2511114 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2511126 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2511146 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2511146 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2511147 INFO (jetty-launcher-1113-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48873/solr
[junit4] 2> 2511216 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2511220 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2511239 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2511240 INFO (jetty-launcher-1113-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48873/solr
[junit4] 2> 2511258 INFO (jetty-launcher-1113-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48873/solr
[junit4] 2> 2511272 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 2511275 INFO (jetty-launcher-1113-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:48873/solr
[junit4] 2> 2511302 INFO (jetty-launcher-1113-thread-3)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:45549_solr
[junit4] 2> 2511318 INFO (jetty-launcher-1113-thread-1)
[n:127.0.0.1:49378_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49378_solr
[junit4] 2> 2511319 INFO (jetty-launcher-1113-thread-3)
[n:127.0.0.1:45549_solr ] o.a.s.c.Overseer Overseer
(id=97158430175789063-127.0.0.1:45549_solr-n_0000000000) starting
[junit4] 2> 2511329 INFO (jetty-launcher-1113-thread-3)
[n:127.0.0.1:45549_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45549_solr
[junit4] 2> 2511368 INFO (jetty-launcher-1113-thread-2)
[n:127.0.0.1:37212_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2511370 INFO
(OverseerStateUpdate-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2511372 INFO (jetty-launcher-1113-thread-2)
[n:127.0.0.1:37212_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37212_solr
[junit4] 2> 2511386 INFO (jetty-launcher-1113-thread-3)
[n:127.0.0.1:45549_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node4/.
[junit4] 2> 2511394 INFO
(zkCallback-1132-thread-1-processing-n:127.0.0.1:49378_solr)
[n:127.0.0.1:49378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 2511427 INFO
(zkCallback-1132-thread-2-processing-n:127.0.0.1:49378_solr)
[n:127.0.0.1:49378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2511447 INFO (jetty-launcher-1113-thread-1)
[n:127.0.0.1:49378_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node1/.
[junit4] 2> 2511449 INFO
(zkCallback-1128-thread-2-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2511452 INFO
(zkCallback-1133-thread-1-processing-n:127.0.0.1:37212_solr)
[n:127.0.0.1:37212_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (2) -> (3)
[junit4] 2> 2511481 INFO (jetty-launcher-1113-thread-2)
[n:127.0.0.1:37212_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node3/.
[junit4] 2> 2511510 INFO (jetty-launcher-1113-thread-4)
[n:127.0.0.1:43166_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 2511580 INFO (jetty-launcher-1113-thread-4)
[n:127.0.0.1:43166_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:43166_solr
[junit4] 2> 2511592 INFO
(zkCallback-1133-thread-1-processing-n:127.0.0.1:37212_solr)
[n:127.0.0.1:37212_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2511592 INFO
(zkCallback-1132-thread-2-processing-n:127.0.0.1:49378_solr)
[n:127.0.0.1:49378_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2511593 INFO
(zkCallback-1136-thread-1-processing-n:127.0.0.1:43166_solr)
[n:127.0.0.1:43166_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2511599 INFO
(zkCallback-1128-thread-2-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (3) -> (4)
[junit4] 2> 2511660 INFO (jetty-launcher-1113-thread-4)
[n:127.0.0.1:43166_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node2/.
[junit4] 2> 2511719 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2511721 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:48873/solr ready
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 2511787 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 2511797 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2511823 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 2511845 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-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_51661_hdfs____r87enz/webapp
[junit4] 2> 2512462 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:51661
[junit4] 2> 2512666 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2512667 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 2512682 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-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_41010_datanode____.3nxftz/webapp
[junit4] 2> 2513197 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:41010
[junit4] 2> 2513271 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 2513272 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 2513331 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-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_50911_datanode____xlqzyd/webapp
[junit4] 2> 2513514 INFO (IPC Server handler 4 on 58198) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-91b360d1-c97e-490e-a20f-b6c5ec920bd2 node
DatanodeRegistration(127.0.0.1:55172,
datanodeUuid=80e03163-9ce7-4b10-8c3a-4b910dd5ae1e, infoPort=58674,
infoSecurePort=0, ipcPort=58385,
storageInfo=lv=-56;cid=testClusterID;nsid=1469804615;c=0), blocks: 0,
hasStaleStorage: true, processing time: 1 msecs
[junit4] 2> 2513514 INFO (IPC Server handler 4 on 58198) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-dfd511ed-fdc4-4f64-adb2-4e3df5c3d297 node
DatanodeRegistration(127.0.0.1:55172,
datanodeUuid=80e03163-9ce7-4b10-8c3a-4b910dd5ae1e, infoPort=58674,
infoSecurePort=0, ipcPort=58385,
storageInfo=lv=-56;cid=testClusterID;nsid=1469804615;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2513907 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:50911
[junit4] 2> 2514103 INFO (IPC Server handler 6 on 58198) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-e706cdbd-24aa-4dee-b0fe-f5133a30cf98 node
DatanodeRegistration(127.0.0.1:52590,
datanodeUuid=dc7529ac-bb4c-43de-8b91-9ce200a4b2eb, infoPort=36190,
infoSecurePort=0, ipcPort=57073,
storageInfo=lv=-56;cid=testClusterID;nsid=1469804615;c=0), blocks: 0,
hasStaleStorage: true, processing time: 2 msecs
[junit4] 2> 2514103 INFO (IPC Server handler 6 on 58198) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-89a95a49-03b4-43e7-bbbc-09dd4aed608f node
DatanodeRegistration(127.0.0.1:52590,
datanodeUuid=dc7529ac-bb4c-43de-8b91-9ce200a4b2eb, infoPort=36190,
infoSecurePort=0, ipcPort=57073,
storageInfo=lv=-56;cid=testClusterID;nsid=1469804615;c=0), blocks: 0,
hasStaleStorage: false, processing time: 0 msecs
[junit4] 2> 2514531 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateNodeSet
[junit4] 2> 2514532 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2514669 INFO (qtp1497730679-172159) [n:127.0.0.1:43166_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:49378/solr,https://127.0.0.1:37212/solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2514682 INFO
(OverseerThreadFactory-3431-thread-1-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd Create collection
nodeset_collection
[junit4] 2> 2514686 WARN
(OverseerThreadFactory-3431-thread-1-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd It is unusual to
create a collection (nodeset_collection) without cores.
[junit4] 2> 2514811 INFO (qtp1497730679-172159) [n:127.0.0.1:43166_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> 2514812 INFO (qtp1497730679-172159) [n:127.0.0.1:43166_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:49378/solr,https://127.0.0.1:37212/solr&wt=javabin&version=2}
status=0 QTime=142
[junit4] 2> 2514813 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateNodeSet-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testCreateNodeSet
[junit4] 2> 2515023 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testBadActionNames-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testBadActionNames
[junit4] 2> 2515153 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testBadActionNames-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2515168 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_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> 2515195 INFO
(OverseerThreadFactory-3431-thread-2-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 2515195 INFO
(OverseerCollectionConfigSetProcessor-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_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> 2515902 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_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=733
[junit4] 2> 2515912 ERROR (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Unknown
action: BADACTION
[junit4] 2> at
org.apache.solr.handler.admin.CollectionsHandler.handleRequestBody(CollectionsHandler.java:203)
[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:318)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:269)
[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:462)
[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> 2515913 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=badactioncollection&action=BADACTION&numShards=2&wt=javabin&version=2}
status=400 QTime=0
[junit4] 2> 2515922 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testBadActionNames-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testBadActionNames
[junit4] 2> 2515923 INFO
(OverseerCollectionConfigSetProcessor-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_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> 2516095 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testZeroNumShards-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testZeroNumShards
[junit4] 2> 2516096 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testZeroNumShards-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2516100 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&numShards=0&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2516116 INFO
(OverseerThreadFactory-3431-thread-3-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd Create collection
acollection
[junit4] 2> 2516117 ERROR
(OverseerThreadFactory-3431-thread-3-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerCollectionMessageHandler
Collection: acollection operation: create
failed:org.apache.solr.common.SolrException: numShards must be > 0
[junit4] 2> at
org.apache.solr.cloud.CreateCollectionCmd.call(CreateCollectionCmd.java:124)
[junit4] 2> at
org.apache.solr.cloud.OverseerCollectionMessageHandler.processMessage(OverseerCollectionMessageHandler.java:224)
[junit4] 2> at
org.apache.solr.cloud.OverseerTaskProcessor$Runner.run(OverseerTaskProcessor.java:463)
[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>
[junit4] 2> 2516130 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=10&collection.configName=conf&name=acollection&action=CREATE&numShards=0&wt=javabin&version=2}
status=400 QTime=30
[junit4] 2> 2516130 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testZeroNumShards-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testZeroNumShards
[junit4] 2> 2516364 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testSpecificConfigsets
[junit4] 2> 2516365 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2516368 INFO (qtp1497730679-172156) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf2&name=withconfigset2&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2516371 INFO
(OverseerCollectionConfigSetProcessor-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2516371 INFO
(OverseerThreadFactory-3431-thread-4-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd Create collection
withconfigset2
[junit4] 2> 2516651 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf2&newCollection=true&name=withconfigset2_shard1_replica1&action=CREATE&numShards=1&collection=withconfigset2&shard=shard1&wt=javabin&version=2
[junit4] 2> 2516755 INFO
(zkCallback-1136-thread-1-processing-n:127.0.0.1:43166_solr)
[n:127.0.0.1:43166_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/withconfigset2/state.json] for collection [withconfigset2]
has occurred - updating... (live nodes size: [4])
[junit4] 2> 2517680 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 2517690 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.s.IndexSchema [withconfigset2_shard1_replica1] Schema name=minimal
[junit4] 2> 2517694 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2517696 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'withconfigset2_shard1_replica1' using
configuration from collection withconfigset2
[junit4] 2> 2517697 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:58198/data
[junit4] 2> 2517698 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 2517698 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1] o.a.s.c.SolrCore
[[withconfigset2_shard1_replica1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node2/withconfigset2_shard1_replica1],
dataDir=[hdfs://localhost:58198/data/withconfigset2/core_node1/data/]
[junit4] 2> 2517698 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7575c7a
[junit4] 2> 2517746 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1] o.a.s.c.SolrCore
[withconfigset2_shard1_replica1] CLOSING SolrCore
org.apache.solr.core.SolrCore@7b52421f
[junit4] 2> 2517747 ERROR (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1] o.a.s.c.SolrCore
Error while closing
[junit4] 2> java.lang.NullPointerException
[junit4] 2> at
org.apache.solr.core.SolrCore.close(SolrCore.java:1347)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:891)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:774)
[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:318)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:269)
[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> 2517747 ERROR (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.c.CoreContainer Error creating core [withconfigset2_shard1_replica1]:
Unrecognized lockType: native
[junit4] 2> org.apache.solr.common.SolrException: Unrecognized lockType:
native
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:899)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:774)
[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:318)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:269)
[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: org.apache.solr.common.SolrException: Unrecognized
lockType: native
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.createLockFactory(HdfsDirectoryFactory.java:178)
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:346)
[junit4] 2> at
org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:433)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:840)
[junit4] 2> ... 39 more
[junit4] 2> 2517756 ERROR (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.h.RequestHandlerBase org.apache.solr.common.SolrException: Error
CREATEing SolrCore 'withconfigset2_shard1_replica1': Unable to create core
[withconfigset2_shard1_replica1] Caused by: Unrecognized lockType: native
[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:318)
[junit4] 2> at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:269)
[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: org.apache.solr.common.SolrException: Unable to
create core [withconfigset2_shard1_replica1]
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:855)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:779)
[junit4] 2> ... 36 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unrecognized
lockType: native
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:899)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:774)
[junit4] 2> at
org.apache.solr.core.CoreContainer.create(CoreContainer.java:842)
[junit4] 2> ... 37 more
[junit4] 2> Caused by: org.apache.solr.common.SolrException: Unrecognized
lockType: native
[junit4] 2> at
org.apache.solr.core.HdfsDirectoryFactory.createLockFactory(HdfsDirectoryFactory.java:178)
[junit4] 2> at
org.apache.solr.core.CachingDirectoryFactory.get(CachingDirectoryFactory.java:346)
[junit4] 2> at
org.apache.solr.core.SolrCore.initSnapshotMetaDataManager(SolrCore.java:433)
[junit4] 2> at
org.apache.solr.core.SolrCore.<init>(SolrCore.java:840)
[junit4] 2> ... 39 more
[junit4] 2>
[junit4] 2> 2517757 INFO (qtp1497730679-172160) [n:127.0.0.1:43166_solr
c:withconfigset2 s:shard1 x:withconfigset2_shard1_replica1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf2&newCollection=true&name=withconfigset2_shard1_replica1&action=CREATE&numShards=1&collection=withconfigset2&shard=shard1&wt=javabin&version=2}
status=400 QTime=1106
[junit4] 2> 2517757 ERROR
(OverseerThreadFactory-3431-thread-4-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerCollectionMessageHandler Error
from shard: https://127.0.0.1:43166/solr
[junit4] 2>
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at https://127.0.0.1:43166/solr: Error CREATEing SolrCore
'withconfigset2_shard1_replica1': Unable to create core
[withconfigset2_shard1_replica1] Caused by: Unrecognized lockType: native
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:610)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:279)
[junit4] 2> at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:268)
[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:163)
[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> 2517757 ERROR
(OverseerThreadFactory-3431-thread-4-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerCollectionMessageHandler Cleaning
up collection [withconfigset2].
[junit4] 2> 2517760 INFO
(OverseerThreadFactory-3431-thread-4-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerCollectionMessageHandler Executing
Collection Cmd : action=UNLOAD&deleteInstanceDir=true&deleteDataDir=true
[junit4] 2> 2517763 INFO (qtp1497730679-172162) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={deleteInstanceDir=true&core=withconfigset2_shard1_replica1&qt=/admin/cores&deleteDataDir=true&action=UNLOAD&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 2518474 INFO
(OverseerThreadFactory-3431-thread-4-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd Cleaned up artifacts
for failed create collection for [withconfigset2]
[junit4] 2> 2518477 INFO (qtp1497730679-172156) [n:127.0.0.1:43166_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> 2520378 INFO
(OverseerCollectionConfigSetProcessor-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2548497 ERROR (qtp1497730679-172156) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CollectionsHandler Timed out waiting for new collection's replicas
to become ACTIVE with timeout=30
[junit4] 2> 2548497 INFO (qtp1497730679-172156) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf2&name=withconfigset2&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=32128
[junit4] 2> 2548498 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending testSpecificConfigsets
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=HdfsCollectionsAPIDistributedZkTest
-Dtests.method=testSpecificConfigsets -Dtests.seed=17C0F5DD0EEBFFF0
-Dtests.multiplier=2 -Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/home/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/test-data/enwiki.random.lines.txt
-Dtests.locale=ja-JP-u-ca-japanese-x-lvariant-JP
-Dtests.timezone=America/Menominee -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] ERROR 32.4s J0 |
HdfsCollectionsAPIDistributedZkTest.testSpecificConfigsets <<<
[junit4] > Throwable #1:
org.apache.zookeeper.KeeperException$NoNodeException: KeeperErrorCode = NoNode
for /collections/withconfigset2
[junit4] > at
__randomizedtesting.SeedInfo.seed([17C0F5DD0EEBFFF0:3ABEBA87F9CF45FC]:0)
[junit4] > at
org.apache.zookeeper.KeeperException.create(KeeperException.java:111)
[junit4] > at
org.apache.zookeeper.KeeperException.create(KeeperException.java:51)
[junit4] > at
org.apache.zookeeper.ZooKeeper.getData(ZooKeeper.java:1155)
[junit4] > at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:356)
[junit4] > at
org.apache.solr.common.cloud.SolrZkClient$7.execute(SolrZkClient.java:353)
[junit4] > at
org.apache.solr.common.cloud.ZkCmdExecutor.retryOperation(ZkCmdExecutor.java:60)
[junit4] > at
org.apache.solr.common.cloud.SolrZkClient.getData(SolrZkClient.java:353)
[junit4] > at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testSpecificConfigsets(CollectionsAPIDistributedZkTest.java:425)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 2548667 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting
deleteCollectionRemovesStaleZkCollectionsNode
[junit4] 2> 2548668 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2548703 INFO (qtp1497730679-172159) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :delete with params
name=out_of_sync_collection&action=DELETE&wt=javabin&version=2 and
sendToOCPQueue=true
[junit4] 2> 2548721 INFO (qtp1497730679-172159) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={name=out_of_sync_collection&action=DELETE&wt=javabin&version=2}
status=0 QTime=18
[junit4] 2> 2548724 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :list with params
action=LIST&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2548725 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_solr
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={action=LIST&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 2548725 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.deleteCollectionRemovesStaleZkCollectionsNode-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Ending
deleteCollectionRemovesStaleZkCollectionsNode
[junit4] 2> 2548927 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.SolrTestCaseJ4 ###Starting testCreateShouldFailOnExistingCore
[junit4] 2> 2548928 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.testCreateShouldFailOnExistingCore-seed#[17C0F5DD0EEBFFF0])
[ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2549037 INFO (qtp350702219-172150) [n:127.0.0.1:45549_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2
[junit4] 2> 2549058 INFO
(OverseerStateUpdate-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 2549102 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 2549111 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema
[halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 2549114 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.s.IndexSchema
Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2549116 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using
configuration from collection halfcollectionblocker
[junit4] 2> 2549116 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:58198/data
[junit4] 2> 2549116 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 2549116 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node4/halfcollection_shard1_replica1],
dataDir=[hdfs://localhost:58198/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003/]
[junit4] 2> 2549116 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003/snapshot_metadata
[junit4] 2> 2549129 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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> 2549129 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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> 2549162 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 2549163 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003
[junit4] 2> 2549232 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003/index
[junit4] 2> 2549255 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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> 2549255 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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> 2549285 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 2549406 INFO (IPC Server handler 8 on 58198) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55172 is
added to blk_1073741825_1001{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-e706cdbd-24aa-4dee-b0fe-f5133a30cf98:NORMAL:127.0.0.1:52590|RBW],
ReplicaUC[[DISK]DS-dfd511ed-fdc4-4f64-adb2-4e3df5c3d297:NORMAL:127.0.0.1:55172|FINALIZED]]}
size 0
[junit4] 2> 2549406 INFO (IPC Server handler 9 on 58198) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:52590 is
added to blk_1073741825_1001 size 71
[junit4] 2> 2549455 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 2549455 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2549455 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 2549506 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2549506 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2549578 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@52f175fd[halfcollection_shard1_replica1] main]
[junit4] 2> 2549579 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 2549580 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 2549580 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2549580 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1554534923559239680
[junit4] 2> 2549583 INFO
(searcherExecutor-3441-thread-1-processing-n:127.0.0.1:45549_solr
x:halfcollection_shard1_replica1 c:halfcollectionblocker)
[n:127.0.0.1:45549_solr c:halfcollectionblocker
x:halfcollection_shard1_replica1] o.a.s.c.SolrCore
[halfcollection_shard1_replica1] Registered new searcher
Searcher@52f175fd[halfcollection_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2549591 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2549591 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2549591 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45549/solr/halfcollection_shard1_replica1/
[junit4] 2> 2549592 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2549592 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy
https://127.0.0.1:45549/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 2549594 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45549/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 2549839 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker x:halfcollection_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2549843 INFO (qtp350702219-172150) [n:127.0.0.1:45549_solr
c:halfcollectionblocker 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-003&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker&wt=javabin&version=2}
status=0 QTime=806
[junit4] 2> 2549947 INFO (qtp224524859-172141) [n:127.0.0.1:49378_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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2
[junit4] 2> 2549955 INFO
(OverseerStateUpdate-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 2550732 INFO
(OverseerCollectionConfigSetProcessor-97158430175789063-127.0.0.1:45549_solr-n_0000000000)
[n:127.0.0.1:45549_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000008 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 2550979 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 6.4.0
[junit4] 2> 2550998 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.IndexSchema [halfcollection_shard1_replica1] Schema name=minimal
[junit4] 2> 2551006 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.IndexSchema Loaded schema minimal/1.1 with uniqueid field id
[junit4] 2> 2551011 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.CoreContainer Creating SolrCore 'halfcollection_shard1_replica1' using
configuration from collection halfcollectionblocker2
[junit4] 2> 2551011 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory solr.hdfs.home=hdfs://localhost:58198/data
[junit4] 2> 2551011 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication disabled
[junit4] 2> 2551011 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-001/node1/halfcollection_shard1_replica1],
dataDir=[hdfs://localhost:58198/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004/]
[junit4] 2> 2551011 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004/snapshot_metadata
[junit4] 2> 2551019 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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> 2551019 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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> 2551024 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 2551028 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004
[junit4] 2> 2551117 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:58198/data/halfcollectionblocker2/core_node1//x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.x/checkout/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004/index
[junit4] 2> 2551124 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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> 2551124 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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> 2551128 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.b.BlockDirectory Block cache on write is disabled
[junit4] 2> 2551288 INFO (IPC Server handler 9 on 58198) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:55172 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-e706cdbd-24aa-4dee-b0fe-f5133a30cf98:NORMAL:127.0.0.1:52590|RBW],
ReplicaUC[[DISK]DS-91b360d1-c97e-490e-a20f-b6c5ec920bd2:NORMAL:127.0.0.1:55172|RBW]]}
size 0
[junit4] 2> 2551293 INFO (IPC Server handler 4 on 58198) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:52590 is
added to blk_1073741826_1002{UCState=UNDER_CONSTRUCTION, truncateBlock=null,
primaryNodeIndex=-1,
replicas=[ReplicaUC[[DISK]DS-91b360d1-c97e-490e-a20f-b6c5ec920bd2:NORMAL:127.0.0.1:55172|RBW],
ReplicaUC[[DISK]DS-89a95a49-03b4-43e7-bbbc-09dd4aed608f:NORMAL:127.0.0.1:52590|FINALIZED]]}
size 0
[junit4] 2> 2551350 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 2551350 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir=null defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2551350 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: tlogDfsReplication=3
[junit4] 2> 2551385 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2551385 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2551437 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@27e20b0c[halfcollection_shard1_replica1] main]
[junit4] 2> 2551438 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 2551438 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 2551438 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 2551438 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1554534925507493888
[junit4] 2> 2551440 INFO
(searcherExecutor-3446-thread-1-processing-n:127.0.0.1:49378_solr
x:halfcollection_shard1_replica1 c:halfcollectionblocker2)
[n:127.0.0.1:49378_solr c:halfcollectionblocker2
x:halfcollection_shard1_replica1] o.a.s.c.SolrCore
[halfcollection_shard1_replica1] Registered new searcher
Searcher@27e20b0c[halfcollection_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2551447 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2551447 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 2551447 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:49378/solr/halfcollection_shard1_replica1/
[junit4] 2> 2551447 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2551447 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.SyncStrategy
https://127.0.0.1:49378/solr/halfcollection_shard1_replica1/ has no replicas
[junit4] 2> 2551455 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:49378/solr/halfcollection_shard1_replica1/ shard1
[junit4] 2> 2551569 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 x:halfcollection_shard1_replica1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2551587 INFO (qtp224524859-172141) [n:127.0.0.1:49378_solr
c:halfcollectionblocker2 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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001/tempDir-004&collection.configName=conf&name=halfcollection_shard1_replica1&action=CREATE&numShards=1&collection=halfcollectionblocker2&wt=javabin&version=2}
status=0 QTime=1640
[junit4] 2> 2551591 INFO (qtp1497730679-172161) [n:127.0.0.1:43166_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:45549_solr,127.0.0.1:49378_solr&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 2551596 INFO
(OverseerThreadFactory-3431-thread-5-processing-n:127.0.0.1:45549_solr)
[n:127.0.0.1:45549_solr ] o.a.s.c.CreateCollectionCmd Create collection
halfcollection
[junit4] 2> 2551838 INFO (qtp224524859-172140) [n:127.0.0.1:49378_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> 2551841 INFO (qtp350702219-172152) [n:127.0.0.1:45549_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> 2551841 WARN (qtp350702219-172152) [n:127.0.0.1:45549_solr
] o.a.s.c.CoreContainer Creating a core with existing name is not allowed
[junit4] 2> 2551841 ERROR (qtp350702219-172152) [n:127.0.0.1:45549_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.HttpSolrCal
[...truncated too long message...]
pool service for: Block pool BP-791627162-10.41.0.5-1482519992726 (Datanode
Uuid 80e03163-9ce7-4b10-8c3a-4b910dd5ae1e) service to localhost/127.0.0.1:58198
[junit4] 2> 2673235 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.m.log Stopped HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:0
[junit4] 2> 2673339 ERROR
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.h.m.l.MethodMetric Error invoking method getBlocksTotal
[junit4] 2> java.lang.reflect.InvocationTargetException
[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
org.apache.hadoop.metrics2.lib.MethodMetric$2.snapshot(MethodMetric.java:111)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MethodMetric.snapshot(MethodMetric.java:144)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MetricsRegistry.snapshot(MetricsRegistry.java:401)
[junit4] 2> at
org.apache.hadoop.metrics2.lib.MetricsSourceBuilder$1.getMetrics(MetricsSourceBuilder.java:79)
[junit4] 2> at
org.apache.hadoop.metrics2.impl.MetricsSourceAdapter.getMetrics(MetricsSourceAdapter.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> ... 54 more
[junit4] 2> 2673344 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-worker) [
] o.a.s.c.ZkTestServer connecting to 127.0.0.1:48873 48873
[junit4] 2> 2673345 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[17C0F5DD0EEBFFF0]-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/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_17C0F5DD0EEBFFF0-001
[junit4] 2> Dec 23, 2016 7:09:14 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 34 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62): {},
docValues:{}, maxPointsInLeafNode=1856, maxMBSortInHeap=6.860035038733794,
sim=RandomSimilarity(queryNorm=true,coord=no): {},
locale=ja-JP-u-ca-japanese-x-lvariant-JP, timezone=America/Menominee
[junit4] 2> NOTE: Linux 3.13.0-85-generic amd64/Oracle Corporation
1.8.0_102 (64-bit)/cpus=4,threads=2,free=133700168,total=471334912
[junit4] 2> NOTE: All tests run in this JVM: [SuggestComponentTest,
DirectoryFactoryTest, AnalysisAfterCoreReloadTest, VersionInfoTest,
TestCryptoKeys, CursorMarkTest, OverriddenZkACLAndCredentialsProvidersTest,
TestStressUserVersions, TestHighlightDedupGrouping,
AsyncCallRequestStatusResponseTest, TestDocSet,
CloudExitableDirectoryReaderTest, TestCorePropertiesReload,
DistributedExpandComponentTest, ShardSplitTest, FileBasedSpellCheckerTest,
TestAnalyzeInfixSuggestions, MBeansHandlerTest, TestFieldCacheSortRandom,
TestCloudInspectUtil, DeleteShardTest, TestRemoteStreaming,
HdfsBasicDistributedZkTest, TestDefaultSearchFieldResource,
ClassificationUpdateProcessorFactoryTest, TestJoin,
TestManagedSchemaThreadSafety, SolrRequestParserTest,
TestTolerantUpdateProcessorCloud, TestValueSourceCache, TestLazyCores,
QueryElevationComponentTest, QueryEqualityTest, HighlighterConfigTest,
TestMinMaxOnMultiValuedField, HdfsRecoveryZkTest, CacheHeaderTest,
CloneFieldUpdateProcessorFactoryTest, HttpPartitionTest, TestSolrCLIRunExample,
ClusterStateTest, TestMissingGroups, TestCloudRecovery, BasicZkTest,
TestRealTimeGet, HdfsLockFactoryTest, TestNonDefinedSimilarityFactory,
TestXmlQParserPlugin, TestExactSharedStatsCache, PeerSyncReplicationTest,
TestRandomFlRTGCloud, TestBinaryResponseWriter, TestFastLRUCache,
TestPseudoReturnFields, TestFunctionQuery, TestSizeLimitedDistributedMap,
ParsingFieldUpdateProcessorsTest, PeerSyncTest,
SimpleCollectionCreateDeleteTest, DefaultValueUpdateProcessorTest,
FastVectorHighlighterTest, TestSolrCoreProperties, CdcrUpdateLogTest,
TestReplicationHandlerBackup, TestFreeTextSuggestions,
SignatureUpdateProcessorFactoryTest, AlternateDirectoryTest,
HdfsCollectionsAPIDistributedZkTest]
[junit4] Completed [301/665 (1!)] on J0 in 172.42s, 20 tests, 1 failure, 1
error <<< FAILURES!
[...truncated 63585 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
