Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-trunk/711/
3 tests failed.
REGRESSION: org.apache.solr.search.TestSearcherReuse.test
Error Message:
expected same:<Searcher@5ade40b5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)
Uninverting(_1(6.0.0):C2) Uninverting(_2(6.0.0):C1) Uninverting(_3(6.0.0):C1)
Uninverting(_4(6.0.0):C1)))}> was not:<Searcher@410633d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)
Uninverting(_1(6.0.0):C2) Uninverting(_2(6.0.0):C1) Uninverting(_3(6.0.0):C1)
Uninverting(_4(6.0.0):C1)))}>
Stack Trace:
java.lang.AssertionError: expected same:<Searcher@5ade40b5[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)
Uninverting(_1(6.0.0):C2) Uninverting(_2(6.0.0):C1) Uninverting(_3(6.0.0):C1)
Uninverting(_4(6.0.0):C1)))}> was not:<Searcher@410633d[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)
Uninverting(_1(6.0.0):C2) Uninverting(_2(6.0.0):C1) Uninverting(_3(6.0.0):C1)
Uninverting(_4(6.0.0):C1)))}>
at
__randomizedtesting.SeedInfo.seed([79C93828E5BF5909:F19D07F24B4334F1]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotSame(Assert.java:641)
at org.junit.Assert.assertSame(Assert.java:580)
at org.junit.Assert.assertSame(Assert.java:593)
at
org.apache.solr.search.TestSearcherReuse.assertSearcherHasNotChanged(TestSearcherReuse.java:247)
at
org.apache.solr.search.TestSearcherReuse.test(TestSearcherReuse.java:117)
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:483)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1627)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:872)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:886)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:845)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:747)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:792)
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:46)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
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:54)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=19293, name=collection5,
state=RUNNABLE, group=TGRP-CollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=19293, name=collection5, state=RUNNABLE,
group=TGRP-CollectionsAPIDistributedZkTest]
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:44324: collection already exists:
awholynewstresscollection_collection5_0
at __randomizedtesting.SeedInfo.seed([79C93828E5BF5909]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1570)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1591)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:895)
FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=870, name=collection0,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=870, name=collection0, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:51887/hun/d: Could not find collection :
awholynewstresscollection_collection0_0
at __randomizedtesting.SeedInfo.seed([79C93828E5BF5909]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:560)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:235)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:227)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:376)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:328)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1086)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:856)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:799)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1220)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:902)
Build Log:
[...truncated 10323 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/init-core-data-001
[junit4] 2> 6534 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false)
[junit4] 2> 6535 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/hun/d
[junit4] 2> 8121 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.h.u.NativeCodeLoader Unable to load native-hadoop library for your
platform... using builtin-java classes where applicable
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 9658 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 9912 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Logging to org.slf4j.impl.Log4jLoggerAdapter(org.mortbay.log) via
org.mortbay.log.Slf4jLog
[junit4] 2> 9922 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 10016 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 10067 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/hdfs
to ./temp/Jetty_localhost_33147_hdfs____gxweda/webapp
[junit4] 2> 10220 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 11183 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:33147
[junit4] 2> 12243 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 12251 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 12268 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_49655_datanode____koc2zc/webapp
[junit4] 2> 12433 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 13068 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:49655
[junit4] 2> 13426 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 13428 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 13462 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Extract
jar:file:/x1/jenkins/.ivy2/cache/org.apache.hadoop/hadoop-hdfs/tests/hadoop-hdfs-2.6.0-tests.jar!/webapps/datanode
to ./temp/Jetty_localhost_42490_datanode____kqdawk/webapp
[junit4] 2> 13625 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 14214 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[79C93828E5BF5909]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:42490
[junit4] 2> 14483 INFO (IPC Server handler 6 on 45475) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-1f05cb9d-bd22-43a2-a189-23b2b4b67b1e node DatanodeRegistration(127.0.0.1,
datanodeUuid=5d39964b-30dc-4d8e-943d-1948ce589640, infoPort=42490,
ipcPort=46836, storageInfo=lv=-56;cid=testClusterID;nsid=537570246;c=0),
blocks: 0, hasStaleStorages: true, processing time: 3 msecs
[junit4] 2> 14488 INFO (IPC Server handler 5 on 45475) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-24a87a82-19ac-4bc4-96dd-206473a05763 node DatanodeRegistration(127.0.0.1,
datanodeUuid=a1f939a6-6f67-4ecb-9b3e-739647715d3f, infoPort=49655,
ipcPort=40446, storageInfo=lv=-56;cid=testClusterID;nsid=537570246;c=0),
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
[junit4] 2> 14492 INFO (IPC Server handler 5 on 45475) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-5ca5e86d-286f-4805-b8ee-5543387acbe6 node DatanodeRegistration(127.0.0.1,
datanodeUuid=a1f939a6-6f67-4ecb-9b3e-739647715d3f, infoPort=49655,
ipcPort=40446, storageInfo=lv=-56;cid=testClusterID;nsid=537570246;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 14498 INFO (IPC Server handler 6 on 45475) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-ad1d6452-d818-4c20-988c-e6cf79168452 node DatanodeRegistration(127.0.0.1,
datanodeUuid=5d39964b-30dc-4d8e-943d-1948ce589640, infoPort=42490,
ipcPort=46836, storageInfo=lv=-56;cid=testClusterID;nsid=537570246;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 15487 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 15490 INFO (Thread-114) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 15490 INFO (Thread-114) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 15589 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkTestServer start zk server on port:43352
[junit4] 2> 15605 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 15642 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 15679 INFO (zkCallback-2-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@70988871
name:ZooKeeperConnection Watcher:127.0.0.1:43352 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 15680 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 15680 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 15682 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 15713 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 15714 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 15716 INFO (zkCallback-3-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@135aba27
name:ZooKeeperConnection Watcher:127.0.0.1:43352/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 15716 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 15717 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 15723 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 15736 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 15740 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 15743 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 15750 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 15758 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 15777 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 15777 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 15782 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 15782 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 15792 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 15795 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 15802 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 15802 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 15805 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 15806 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 15809 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 15809 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 15812 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 15812 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 15817 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 15818 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 15821 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 15821 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 15824 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 15824 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 16192 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1
[junit4] 2> 16221 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.u.log Logging initialized @19295ms
[junit4] 2> 16365 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 16483 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@8163594{/hun/d,null,AVAILABLE}
[junit4] 2> 16498 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@7eca7320{HTTP/1.1}{127.0.0.1:51887}
[junit4] 2> 16499 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.Server Started @19573ms
[junit4] 2> 16503 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:45475/hdfs__localhost_45475__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-trunk_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001_tempDir-002_control_data,
hostContext=/hun/d, hostPort=51887,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores}
[junit4] 2> 16509 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 16509 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/'
[junit4] 2> 16532 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/solr.xml
[junit4] 2> 16550 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores
[junit4] 2> 16551 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer New CoreContainer 1760956372
[junit4] 2> 16551 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/]
[junit4] 2> 16552 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/lib
[junit4] 2> 16552 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/lib).
[junit4] 2> 16586 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 16589 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 16589 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 16590 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 16590 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43352/solr
[junit4] 2> 16608 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 16608 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 16609 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 16616 INFO (zkCallback-5-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6bf8f379
name:ZooKeeperConnection Watcher:127.0.0.1:43352 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 16621 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 16622 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 16648 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@440b646b
name:ZooKeeperConnection Watcher:127.0.0.1:43352/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 16631 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 16651 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 16666 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath: /overseer/queue
[junit4] 2> 16674 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 16681 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 16685 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 16691 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 16707 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 16724 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 16727 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 16729 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:51887_hun%2Fd
[junit4] 2> 16735 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:51887_hun%2Fd
[junit4] 2> 16741 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath: /overseer_elect
[junit4] 2> 16751 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 16761 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 16789 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:51887_hun%2Fd
[junit4] 2> 16789 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 16792 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer Overseer
(id=93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000) starting
[junit4] 2> 16799 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 16824 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 16828 INFO
(OverseerCollectionProcessor-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.OverseerCollectionProcessor Process
current queue of collection creations
[junit4] 2> 16829 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 16835 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 16859 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 16861 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 16862 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.CoresLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores
[junit4] 2> 16866 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1,
collection=control_collection,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 16867 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1/
[junit4] 2> 16867 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 16875 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 16876 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 16877 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 16877 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 16883 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 16883 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 16889 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:51887/hun/d";,
[junit4] 2> "node_name":"127.0.0.1:51887_hun%2Fd",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 0
[junit4] 2> 16900 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:51887/hun/d";,
[junit4] 2> "node_name":"127.0.0.1:51887_hun%2Fd",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 16901 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 16912 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.o.ReplicaMutator Assigning new node to
shard shard=shard1
[junit4] 2> 16920 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader A cluster state change:
WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json,
has occurred - updating... (live nodes size: 1)
[junit4] 2> 16928 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 1
[junit4] 2> 17886 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 17886 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 17891 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 17891 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 17895 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=/collections/control_collection configName=conf1
specified config exists in ZooKeeper
[junit4] 2> 17895 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1/'
[junit4] 2> 17946 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1] o.a.s.c.Config
loaded config solrconfig.xml with version 0
[junit4] 2> 17968 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 17983 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 18010 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1] o.a.s.c.Config
Loaded SolrConfig: solrconfig.xml
[junit4] 2> 18014 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.IndexSchema Reading Solr Schema from /configs/conf1/schema.xml
[junit4] 2> 18073 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 18382 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 18391 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 18394 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 18452 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 18460 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 18467 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 18470 WARN
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 18471 WARN
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 18471 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 18476 WARN
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Unknown key IMPORTANT NOTE
[junit4] 2> 18476 WARN
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Expected key, got STRING
[junit4] 2> 18478 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 18479 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
[junit4] 2> 18490 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:45475/solr_hdfs_home
[junit4] 2> 18491 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication
disabled
[junit4] 2> 18491 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/control-001/cores/collection1/],
dataDir=[null]
[junit4] 2> 18493 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr
mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@175f9ebd
[junit4] 2> 18508 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 18638 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data for
locality metrics.
[junit4] 2> 18638 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 18647 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data/index/
[junit4] 2> 18752 WARN
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'hdfs:/localhost:45475/solr_hdfs_home/control_collection/core_node1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 18762 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 18804 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.h.HdfsLocalityReporter Registering direcotry
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data/index
for locality metrics.
[junit4] 2> 18805 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 18806 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=6, maxMergeAtOnceExplicit=7, maxMergedSegmentMB=12.5947265625,
floorSegmentMB=1.6845703125, forceMergeDeletesPctAllowed=2.654371572902531,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.28226008910424505
[junit4] 2> 19220 INFO (IPC Server handler 1 on 45475) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:42852 is
added to blk_1073741825_1001{blockUCState=COMMITTED, primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-1f05cb9d-bd22-43a2-a189-23b2b4b67b1e:NORMAL:127.0.0.1:37437|RBW],
ReplicaUnderConstruction[[DISK]DS-5ca5e86d-286f-4805-b8ee-5543387acbe6:NORMAL:127.0.0.1:42852|RBW]]}
size 71
[junit4] 2> 19221 INFO (IPC Server handler 2 on 45475) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37437 is
added to blk_1073741825_1001 size 71
[junit4] 2> 19637 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(HdfsDirectory@b771b66d
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c406934;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 19638 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 19645 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SolrCore
Looking for old index directories to cleanup for core collection1 in
hdfs://localhost:45475/solr_hdfs_home/control_collection/core_node1/data/
[junit4] 2> 19653 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 19670 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 19671 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 19671 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 19678 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 19678 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-explicit"
[junit4] 2> 19678 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "distrib-dup-test-chain-implicit"
[junit4] 2> 19680 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain
"distrib-dup-test-chain-implicit"
[junit4] 2> 19680 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore no updateRequestProcessorChain defined as
default, creating implicit default
[junit4] 2> 19688 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 19699 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 19701 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 19702 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 19724 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/update/csv,/update/json/docs,/admin/luke,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/schema,/admin/plugins,/admin/logging,/update/json,/admin/threads,/admin/ping,/update,/admin/file
[junit4] 2> 19732 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Using default statsCache cache:
org.apache.solr.search.stats.LocalStatsCache
[junit4] 2> 19735 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.HdfsUpdateLog
[junit4] 2> 19735 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Initializing HdfsUpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
tlogDfsReplication=2
[junit4] 2> 19807 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Hard AutoCommit: disabled
[junit4] 2> 19808 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore Soft AutoCommit: disabled
[junit4] 2> 19818 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=12, maxMergeAtOnceExplicit=31, maxMergedSegmentMB=78.0146484375,
floorSegmentMB=2.0732421875, forceMergeDeletesPctAllowed=7.3826523237640815,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.28749322901482977
[junit4] 2> 20003 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=NRTCachingDirectory(HdfsDirectory@b771b66d
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@5c406934;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 20004 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore newest commit generation = 1
[junit4] 2> 20004 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening Searcher@2f30ef3[collection1]
main
[junit4] 2> 20005 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Load collection config
from:/collections/control_collection
[junit4] 2> 20007 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader path=/collections/control_collection
configName=conf1 specified config exists in ZooKeeper
[junit4] 2> 20007 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Setting up ZooKeeper-based
storage for the RestManager with znodeBase: /configs/conf1
[junit4] 2> 20030 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 20030 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 20031 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Reading _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 20032 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage No data found for znode
/configs/conf1/_rest_managed.json
[junit4] 2> 20033 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Loaded null at path
_rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 20033 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 20034 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 20038 INFO
(searcherExecutor-19-thread-1-processing-n:127.0.0.1:51887_hun%2Fd
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@2f30ef3[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 20052 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Looking up max value of version field to seed
version buckets
[junit4] 2> 20053 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo Refreshing highest value of _version_ for
256 version buckets from index
[junit4] 2> 20053 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.VersionInfo No terms found for _version_, cannot seed
version bucket highest value from index
[junit4] 2> 20053 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Could not find max version in index or recent
updates, using new clock 1503954247884996608
[junit4] 2> 20053 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 1 ms to seed version buckets with highest
version 1503954247884996608
[junit4] 2> 20055 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 20058 INFO
(coreLoadExecutor-18-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 20060 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
Register replica - core:collection1 address:http://127.0.0.1:51887/hun/d
collection:control_collection shard:shard1
[junit4] 2> 20068 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leader_elect/shard1/election
[junit4] 2> 20079 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Running the leader process for shard shard1
[junit4] 2> 20082 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 20084 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection"} current state version: 1
[junit4] 2> 20087 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 20087 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 20088 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:51887/hun/d/collection1/
[junit4] 2> 20088 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader A cluster state change:
WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json,
has occurred - updating... (live nodes size: 1)
[junit4] 2> 20090 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 20090 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:51887/hun/d/collection1/ has no replicas
[junit4] 2> 20090 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:51887/hun/d/collection1/ shard1
[junit4] 2> 20094 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 2
[junit4] 2> 20096 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/leaders/shard1
[junit4] 2> 20109 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 20114 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "operation":"leader",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "base_url":"http://127.0.0.1:51887/hun/d";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 20219 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader A cluster state change:
WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json,
has occurred - updating... (live nodes size: 1)
[junit4] 2> 20224 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 3
[junit4] 2> 20261 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
We are http://127.0.0.1:51887/hun/d/collection1/ and leader is
http://127.0.0.1:51887/hun/d/collection1/
[junit4] 2> 20262 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
No LogReplay needed for core=collection1 baseURL=http://127.0.0.1:51887/hun/d
[junit4] 2> 20262 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 20262 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
publishing state=active
[junit4] 2> 20262 INFO
(coreZkRegister-12-thread-1-processing-n:127.0.0.1:51887_hun%2Fd x:collection1
s:shard1 c:control_collection r:core_node1) [n:127.0.0.1:51887_hun%2Fd
c:control_collection s:shard1 r:core_node1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 20265 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 20268 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.Overseer processMessage: queueSize: 1,
message = {
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:51887/hun/d";,
[junit4] 2> "node_name":"127.0.0.1:51887_hun%2Fd",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"} current state version: 3
[junit4] 2> 20268 INFO
(OverseerStateUpdate-93997140197834755-127.0.0.1:51887_hun%2Fd-n_0000000000)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.o.ReplicaMutator Update state
numShards=1 message={
[junit4] 2> "core":"collection1",
[junit4] 2> "core_node_name":"core_node1",
[junit4] 2> "roles":null,
[junit4] 2> "base_url":"http://127.0.0.1:51887/hun/d";,
[junit4] 2> "node_name":"127.0.0.1:51887_hun%2Fd",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 20378 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader A cluster state change:
WatchedEvent state:SyncConnected type:NodeDataChanged path:/clusterstate.json,
has occurred - updating... (live nodes size: 1)
[junit4] 2> 20387 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.c.ZkStateReader Updated cluster state
version to 4
[junit4] 2> 20435 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 20438 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 20443 INFO (zkCallback-8-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@1e4695d9
name:ZooKeeperConnection Watcher:127.0.0.1:43352/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 20443 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 20444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 20444 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ZkStateReader Updating cluster state from ZooKeeper...
[junit4] 2> 20458 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 20907 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores/collection1
[junit4] 2> 20915 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001
[junit4] 2> 20926 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.Server jetty-9.2.11.v20150529
[junit4] 2> 20936 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5acdaaad{/hun/d,null,AVAILABLE}
[junit4] 2> 20937 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@1ce88948{HTTP/1.1}{127.0.0.1:48078}
[junit4] 2> 20937 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.e.j.s.Server Started @24012ms
[junit4] 2> 20938 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:45475/hdfs__localhost_45475__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-trunk_solr_build_solr-core_test_J0_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001_tempDir-002_jetty1,
solrconfig=solrconfig.xml, hostContext=/hun/d, hostPort=48078,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores}
[junit4] 2> 20938 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@c387f44
[junit4] 2> 20938 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/'
[junit4] 2> 20984 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/solr.xml
[junit4] 2> 21004 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoresLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores
[junit4] 2> 21004 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer New CoreContainer 711893395
[junit4] 2> 21005 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/]
[junit4] 2> 21005 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.CoreContainer loading shared library:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/lib
[junit4] 2> 21005 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.SolrResourceLoader Can't find (or read) directory to add to
classloader: lib (resolved as:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/lib).
[junit4] 2> 21051 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.h.c.HttpShardHandlerFactory created with socketTimeout : 90000,urlScheme
: ,connTimeout : 15000,maxConnectionsPerHost : 20,maxConnections :
10000,corePoolSize : 0,maximumPoolSize : 2147483647,maxThreadIdleTime :
5,sizeOfQueue : -1,fairnessPolicy : false,useRetries : false,
[junit4] 2> 21052 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 21053 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 21053 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 21053 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:43352/solr
[junit4] 2> 21054 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 21054 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 21101 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 21118 INFO (zkCallback-10-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5bc4b88 name:ZooKeeperConnection
Watcher:127.0.0.1:43352 got event WatchedEvent state:SyncConnected type:None
path:null path:null type:None
[junit4] 2> 21123 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 21124 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 21159 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 21183 INFO
(zkCallback-11-thread-1-processing-n:127.0.0.1:48078_hun%2Fd)
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@39f7d654
name:ZooKeeperConnection Watcher:127.0.0.1:43352/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 21183 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 21209 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.c.ZkStateReader Updating cluster state
from ZooKeeper...
[junit4] 2> 22217 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:48078_hun%2Fd
[junit4] 2> 22218 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:48078_hun%2Fd
[junit4] 2> 22225 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 22229 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.CoreContainer No authentication plugin
used.
[junit4] 2> 22229 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 22230 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.CoresLocator Looking for core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores
[junit4] 2> 22233 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.SolrCore Created CoreDescriptor:
{name=collection1, config=solrconfig.xml, transient=false, schema=schema.xml,
loadOnStartup=true,
instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores/collection1,
collection=collection1,
absoluteInstDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores/collection1/,
coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 22234 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.CoresLocator Found core collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_79C93828E5BF5909-001/shard-1-001/cores/collection1/
[junit4] 2> 22234 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.c.CoresLocator Found 1 core definitions
[junit4] 2> 22263 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J0
[junit4] 2> 22272 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[79C93828E5BF5909])
[n:127.0.0.1:48078_hun%2Fd ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 22272 INFO
(coreLoadExecutor-29-thread-1-processing-n:127.0.0.1:48078_hun%2Fd)
[n:127.0.0.1:48078_hun%2Fd c:collection1 x:collection1] o.a.s.c.ZkController
publishing state=down
[junit4] 2> 22272 INFO
(coreLoadExecutor-29-thread-1-processing-n:127.0.0.1:48078_hun%2Fd)
[n:127.0.0.1:48078_hun%2Fd c:collection1 x:collection1] o.a.s.c.ZkController
numShards not found on descriptor - reading it from system property
[junit4] 2> 22274 INFO
(zkCallback-6-thread-1-processing-n:127.0.0.1:51887_hun%2Fd)
[n:127.0.0.1:51887_hun%2Fd ] o.a.s.c.DistributedQueue NodeChildrenChanged
fired on path /overseer/queue state SyncConnected
[junit4] 2> 22279 INFO
(coreLoadExecutor-29-thread-1-processing-n:127.0.0.1:48078_hun%2Fd)
[n:127.0.0.1:48078_hun%2Fd c:collection1 x:collection1] o.a.s.c.ZkController
look for our core node name
[junit4] 2> 22280 INFO (OverseerSta
[...truncated too long message...]
O (SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=33538679
[junit4] 2> 3842432 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.SolrCore [collection1] CLOSING SolrCore
org.apache.solr.core.SolrCore@10992e2
[junit4] 2> 3842432 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.u.UpdateHandler closing
DirectUpdateHandler2{commits=12,autocommits=0,soft
autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=6,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
[junit4] 2> 3842433 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.u.SolrCoreState Closing SolrCoreState
[junit4] 2> 3842433 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.u.DefaultSolrCoreState SolrCoreState ref count has reached 0 - closing
IndexWriter
[junit4] 2> 3842433 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.u.DefaultSolrCoreState closing IndexWriter with IndexWriterCloser
[junit4] 2> 3842433 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.SolrCore [collection1] Closing main searcher on request.
[junit4] 2> 3842433 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing NRTCachingDirectoryFactory - 2
directories currently being tracked
[junit4] 2> 3842434 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001/index
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001/index;done=false>>]
[junit4] 2> 3842434 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001/index
[junit4] 2> 3842434 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001;done=false>>]
[junit4] 2> 3842434 INFO
(SUITE-TestSearcherReuse-seed#[79C93828E5BF5909]-worker) [ x:collection1]
o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001/init-core-data-001
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build/solr-core/test/J1/temp/solr.search.TestSearcherReuse_79C93828E5BF5909-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene53): {},
docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {},
locale=sv, timezone=Pacific/Midway
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_25 (64-bit)/cpus=4,threads=1,free=326368832,total=521142272
[junit4] 2> NOTE: All tests run in this JVM: [TestFoldingMultitermQuery,
TestCustomDocTransformer, ActionThrottleTest, TestDistributedGrouping,
JsonLoaderTest, DateRangeFieldTest, TestSolrQueryParserDefaultOperatorResource,
TestStressUserVersions, ConvertedLegacyTest, TestValueSourceCache,
OpenCloseCoreStressTest, TestFastLRUCache, FieldAnalysisRequestHandlerTest,
TestMiniSolrCloudClusterSSL, AddBlockUpdateTest, BlockDirectoryTest,
AlternateDirectoryTest, TestFastWriter, ZkCLITest, ZkControllerTest,
TestManagedSchemaFieldTypeResource, TestComponentsName, TestFieldSortValues,
OverseerStatusTest, NoCacheHeaderTest, WordBreakSolrSpellCheckerTest,
FileUtilsTest, ShardRoutingCustomTest, TestRTGBase, TestCharFilters,
TestJsonRequest, MergeStrategyTest, SpellingQueryConverterTest,
SpellPossibilityIteratorTest, DocValuesMultiTest, TestMaxScoreQueryParser,
DeleteReplicaTest, DistanceUnitsTest, DeleteShardTest,
TestCursorMarkWithoutUniqueKey, DocumentBuilderTest, TestWriterPerf,
AnalysisAfterCoreReloadTest, OverriddenZkACLAndCredentialsProvidersTest,
SpellCheckComponentTest, SuggesterTSTTest,
CollectionsAPIAsyncDistributedZkTest, JavabinLoaderTest, RuleEngineTest,
LukeRequestHandlerTest, PreAnalyzedFieldTest, ChaosMonkeySafeLeaderTest,
ShardRoutingTest, TestFiltering, TestBulkSchemaAPI, SolrPluginUtilsTest,
TestReplicationHandlerBackup, DistributedDebugComponentTest, AtomicUpdatesTest,
AsyncMigrateRouteKeyTest, CacheHeaderTest, TestTolerantSearch,
UUIDUpdateProcessorFallbackTest, TestIndexSearcher, SolrXmlInZkTest,
TestLRUStatsCache, TestIntervalFaceting, ResourceLoaderTest, EchoParamsTest,
TestClusterStateMutator, TestDistributedStatsComponentCardinality,
DocumentAnalysisRequestHandlerTest, ScriptEngineTest, SystemInfoHandlerTest,
TestSuggestSpellingConverter, DistributedQueryComponentOptimizationTest,
CloudMLTQParserTest, TestMiniSolrCloudCluster, ZkSolrClientTest,
SolrCloudExampleTest, TestInitParams, TestManagedSchemaFieldResource,
HdfsBasicDistributedZk2Test, TestOmitPositions,
CollectionsAPIDistributedZkTest, DistributedTermsComponentTest,
ClusterStateUpdateTest, TestRandomFaceting, LeaderElectionTest, TestZkChroot,
AutoCommitTest, TestFaceting, TestHashPartitioner,
DistributedSpellCheckComponentTest, TermVectorComponentDistributedTest,
TestRealTimeGet, TestJoin, TestReload, TestStressVersions, TestRangeQuery,
TestCoreContainer, SimpleFacetsTest, StatsComponentTest,
SolrCmdDistributorTest, PeerSyncTest, TestFunctionQuery,
BasicFunctionalityTest, DirectUpdateHandlerTest, TestBadConfig,
ShowFileRequestHandlerTest, CurrencyFieldOpenExchangeTest,
SolrIndexSplitterTest, TestCoreDiscovery, SignatureUpdateProcessorFactoryTest,
SuggesterFSTTest, CoreAdminHandlerTest, SolrRequestParserTest, DocValuesTest,
SuggesterTest, TestStressLucene, TestTrie, SpatialFilterTest, PolyFieldTest,
SolrCoreCheckLockOnStartupTest, TestPseudoReturnFields, TestUpdate,
FieldMutatingUpdateProcessorTest, TestAtomicUpdateErrorCases,
StatelessScriptUpdateProcessorFactoryTest, SortByFunctionTest,
DistanceFunctionTest, SolrInfoMBeanTest, XsltUpdateRequestHandlerTest,
DisMaxRequestHandlerTest, TestQueryUtils, StandardRequestHandlerTest,
DirectSolrSpellCheckerTest, TestReversedWildcardFilterFactory,
XmlUpdateRequestHandlerTest, RequestHandlersTest,
PathHierarchyTokenizerFactoryTest, TermVectorComponentTest, RequiredFieldsTest,
TestArbitraryIndexDir, FastVectorHighlighterTest, IndexSchemaRuntimeFieldTest,
RegexBoostProcessorTest, ReturnFieldsTest, JSONWriterTest, MBeansHandlerTest,
TestAnalyzedSuggestions, TestPartialUpdateDeduplication,
TestPHPSerializedResponseWriter, CSVRequestHandlerTest, SearchHandlerTest,
TestLFUCache, TestSystemIdResolver, PrimUtilsTest, RAMDirectoryFactoryTest,
ClusterStateTest, TestSolrJ, TestLRUCache, TestUtils, TestDocumentBuilder,
SliceStateTest, UUIDFieldTest, CircularListTest, DistributedMLTComponentTest,
CursorPagingTest, DistributedIntervalFacetingTest, CleanupOldIndexTest,
ConnectionManagerTest, CustomCollectionTest,
DistribDocExpirationUpdateProcessorTest, MultiThreadedOCPTest,
TestAuthenticationFramework, TestCloudInspectUtil, TestCollectionAPI,
TestCryptoKeys, TestDownShardTolerantSearch, TestRandomRequestDistribution,
TestRebalanceLeaders, TestRequestStatusCollectionAPI,
TestShortCircuitedRequests, VMParamsZkACLAndCredentialsProvidersTest,
HdfsChaosMonkeySafeLeaderTest, HdfsRecoverLeaseTest, HdfsRecoveryZkTest,
HdfsThreadLeakTest, HdfsUnloadDistributedZkTest, StressHdfsTest,
TestSearcherReuse]
[junit4] Completed [481/508] on J1 in 0.71s, 1 test, 1 failure <<< FAILURES!
[...truncated 92 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:533:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:474:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/build.xml:61:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/extra-targets.xml:39:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/build.xml:230:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/solr/common-build.xml:512:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:1426:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-trunk/lucene/common-build.xml:981:
There were test failures: 508 suites, 2006 tests, 2 errors, 1 failure, 20
ignored (10 assumptions)
Total time: 169 minutes 26 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
No prior successful build to compare, so performing full copy of artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
