Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-6.0/4/
3 tests failed.
FAILED: org.apache.solr.client.solrj.ConnectionReuseTest.test
Error Message:
We expected all communication via streaming client to use one connection!
expected=266 got=262
Stack Trace:
java.lang.AssertionError: We expected all communication via streaming client to
use one connection! expected=266 got=262
at
__randomizedtesting.SeedInfo.seed([C85C326321D2AD74:40080DB98F2EC08C]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at
org.apache.solr.client.solrj.ConnectionReuseTest.test(ConnectionReuseTest.java:150)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
FAILED: org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest.test
Error Message:
Captured an uncaught exception in thread: Thread[id=3677, name=collection5,
state=RUNNABLE, group=TGRP-HdfsCollectionsAPIDistributedZkTest]
Stack Trace:
com.carrotsearch.randomizedtesting.UncaughtExceptionError: Captured an uncaught
exception in thread: Thread[id=3677, name=collection5, state=RUNNABLE,
group=TGRP-HdfsCollectionsAPIDistributedZkTest]
at
__randomizedtesting.SeedInfo.seed([C85C326321D2AD74:40080DB98F2EC08C]:0)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:57510/lfzr/wf: collection already exists:
awholynewstresscollection_collection5_3
at __randomizedtesting.SeedInfo.seed([C85C326321D2AD74]:0)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:577)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:372)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:325)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:1100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:870)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:806)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1593)
at
org.apache.solr.cloud.AbstractFullDistribZkTestBase.createCollection(AbstractFullDistribZkTestBase.java:1614)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest$1CollectionThread.run(CollectionsAPIDistributedZkTest.java:973)
FAILED: org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test
Error Message:
Timeout occured while waiting response from server at: http://127.0.0.1:37023
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: Timeout occured while waiting
response from server at: http://127.0.0.1:37023
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:588)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:241)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:230)
at org.apache.solr.client.solrj.SolrClient.request(SolrClient.java:1219)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.makeRequest(CollectionsAPIDistributedZkTest.java:382)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.testErrorHandling(CollectionsAPIDistributedZkTest.java:459)
at
org.apache.solr.cloud.CollectionsAPIDistributedZkTest.test(CollectionsAPIDistributedZkTest.java:169)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Caused by: java.net.SocketTimeoutException: Read timed out
at java.net.SocketInputStream.socketRead0(Native Method)
at java.net.SocketInputStream.socketRead(SocketInputStream.java:116)
at java.net.SocketInputStream.read(SocketInputStream.java:170)
at java.net.SocketInputStream.read(SocketInputStream.java:141)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.fillBuffer(AbstractSessionInputBuffer.java:160)
at
org.apache.http.impl.io.SocketInputBuffer.fillBuffer(SocketInputBuffer.java:84)
at
org.apache.http.impl.io.AbstractSessionInputBuffer.readLine(AbstractSessionInputBuffer.java:273)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:140)
at
org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:57)
at
org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:261)
at
org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:283)
at
org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:251)
at
org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:197)
at
org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:272)
at
org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:124)
at
org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:685)
at
org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:487)
at
org.apache.http.impl.client.AbstractHttpClient.doExecute(AbstractHttpClient.java:882)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:82)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:107)
at
org.apache.http.impl.client.CloseableHttpClient.execute(CloseableHttpClient.java:55)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:482)
... 47 more
Build Log:
[...truncated 11286 lines...]
[junit4] Suite:
org.apache.solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/init-core-data-001
[junit4] 2> 395855 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true)
[junit4] 2> 395855 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property:
/lfzr/wf
[junit4] 1> Formatting using clusterid: testClusterID
[junit4] 2> 395998 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.h.m.i.MetricsConfig Cannot locate configuration: tried
hadoop-metrics2-namenode.properties,hadoop-metrics2.properties
[junit4] 2> 396068 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 396069 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 396106 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-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_52124_hdfs____u8wd28/webapp
[junit4] 2> 396189 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 396561 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:52124
[junit4] 2> 397129 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 397130 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 397137 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-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_44268_datanode____b9ynkr/webapp
[junit4] 2> 397253 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 397615 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:44268
[junit4] 2> 397757 WARN
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.a.h.h.HttpRequestLog Jetty request log can only be enabled using Log4j
[junit4] 2> 397761 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log jetty-6.1.26
[junit4] 2> 397770 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-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_48172_datanode____.qobhw1/webapp
[junit4] 2> 398054 INFO (IPC Server handler 3 on 40890) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-6a81d2ca-cf6d-44a7-997f-13a27204d00c node DatanodeRegistration(127.0.0.1,
datanodeUuid=48ab65d7-ddad-4c0b-ba88-fb828f1b444f, infoPort=44268,
ipcPort=47711, storageInfo=lv=-56;cid=testClusterID;nsid=1044962293;c=0),
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
[junit4] 2> 398054 INFO (IPC Server handler 3 on 40890) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-d4c26d8a-154d-4c8e-acc0-9f6eb5c7a465 node DatanodeRegistration(127.0.0.1,
datanodeUuid=48ab65d7-ddad-4c0b-ba88-fb828f1b444f, infoPort=44268,
ipcPort=47711, storageInfo=lv=-56;cid=testClusterID;nsid=1044962293;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 398103 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log NO JSP Support for /, did not find
org.apache.jasper.servlet.JspServlet
[junit4] 2> 398421 INFO
(SUITE-HdfsCollectionsAPIDistributedZkTest-seed#[C85C326321D2AD74]-worker) [
] o.m.log Started
HttpServer2$SelectChannelConnectorWithSafeStartup@localhost:48172
[junit4] 2> 398570 INFO (IPC Server handler 5 on 40890) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-5c88031e-1186-4e6e-bc50-7fe485ae3fa1 node DatanodeRegistration(127.0.0.1,
datanodeUuid=89bcf6b6-2abe-4b1a-89bf-b50a51ed68c0, infoPort=48172,
ipcPort=50493, storageInfo=lv=-56;cid=testClusterID;nsid=1044962293;c=0),
blocks: 0, hasStaleStorages: true, processing time: 0 msecs
[junit4] 2> 398570 INFO (IPC Server handler 5 on 40890) [ ]
BlockStateChange BLOCK* processReport: from storage
DS-06408f8c-b87e-4554-87b4-de921ab5014d node DatanodeRegistration(127.0.0.1,
datanodeUuid=89bcf6b6-2abe-4b1a-89bf-b50a51ed68c0, infoPort=48172,
ipcPort=50493, storageInfo=lv=-56;cid=testClusterID;nsid=1044962293;c=0),
blocks: 0, hasStaleStorages: false, processing time: 0 msecs
[junit4] 2> 398757 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 398757 INFO (Thread-1240) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 398757 INFO (Thread-1240) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 398861 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.ZkTestServer start zk server on port:35758
[junit4] 2> 398861 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 398881 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 398889 INFO (zkCallback-289-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@47bd3db2
name:ZooKeeperConnection Watcher:127.0.0.1:35758 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 398889 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 398889 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 398889 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 398937 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 398959 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 398981 INFO (zkCallback-290-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@5c80bfaf
name:ZooKeeperConnection Watcher:127.0.0.1:35758/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 398981 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 398982 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 398982 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1
[junit4] 2> 398982 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/collection1/shards
[junit4] 2> 398983 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection
[junit4] 2> 398983 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /collections/control_collection/shards
[junit4] 2> 398984 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 398984 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/solrconfig.xml
[junit4] 2> 398985 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 398985 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/schema.xml
[junit4] 2> 398986 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 398986 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 398987 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 398987 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/stopwords.txt
[junit4] 2> 398987 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 398987 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/protwords.txt
[junit4] 2> 398997 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 398997 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/currency.xml
[junit4] 2> 398998 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 398998 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/enumsConfig.xml
[junit4] 2> 398999 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 398999 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/open-exchange-rates.json
[junit4] 2> 398999 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 398999 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 399005 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 399005 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/old_synonyms.txt
[junit4] 2> 399006 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 399006 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf1/synonyms.txt
[junit4] 2> 399013 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 399049 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 399073 INFO (zkCallback-291-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3aea74a3
name:ZooKeeperConnection Watcher:127.0.0.1:35758 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 399073 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 399073 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 399073 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /solr
[junit4] 2> 399074 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 399081 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 399097 INFO (zkCallback-292-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@46b5277f
name:ZooKeeperConnection Watcher:127.0.0.1:35758/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 399097 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 399097 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 399098 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf2/solrconfig.xml
[junit4] 2> 399098 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/solrconfig.xml
[junit4] 2> 399110 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf2/schema.xml
[junit4] 2> 399110 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/schema.xml
[junit4] 2> 399110 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf2/enumsConfig.xml
[junit4] 2> 399111 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/enumsConfig.xml
[junit4] 2> 399111 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 399111 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath:
/configs/conf2/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 399112 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf2/stopwords.txt
[junit4] 2> 399112 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/stopwords.txt
[junit4] 2> 399112 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf2/protwords.txt
[junit4] 2> 399112 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/protwords.txt
[junit4] 2> 399290 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf2/currency.xml
[junit4] 2> 399290 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/currency.xml
[junit4] 2> 399291 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf2/open-exchange-rates.json
[junit4] 2> 399291 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/open-exchange-rates.json
[junit4] 2> 399291 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 399291 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/mapping-ISOLatin1Accent.txt
[junit4] 2> 399292 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf2/old_synonyms.txt
[junit4] 2> 399292 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/old_synonyms.txt
[junit4] 2> 399293 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf2/synonyms.txt
[junit4] 2> 399293 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/synonyms.txt
[junit4] 2> 399293 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/core/src/test-files/solr/collection1/conf/elevate.xml
to /configs/conf2/elevate.xml
[junit4] 2> 399293 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient makePath: /configs/conf2/elevate.xml
[junit4] 2> 399370 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores/collection1
[junit4] 2> 399374 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 399378 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3dc2cdbf{/lfzr/wf,null,AVAILABLE}
[junit4] 2> 399378 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@75be7c5{HTTP/1.1,[http/1.1]}{127.0.0.1:58402}
[junit4] 2> 399378 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.Server Started @405270ms
[junit4] 2> 399378 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=hdfs://localhost:40890/hdfs__localhost_40890__x1_jenkins_jenkins-slave_workspace_Lucene-Solr-NightlyTests-6.0_solr_build_solr-core_test_J1_temp_solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001_tempDir-002_control_data,
hostContext=/lfzr/wf, hostPort=58402,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores}
[junit4] 2> 399379 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.s.SolrDispatchFilter SolrDispatchFilter.init():
sun.misc.Launcher$AppClassLoader@73d16e93
[junit4] 2> 399379 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001'
[junit4] 2> 399379 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 399379 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 399380 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 399380 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 399381 INFO (zkCallback-293-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@6cbfb269
name:ZooKeeperConnection Watcher:127.0.0.1:35758/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 399381 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 399381 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 399383 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 399383 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/solr.xml
[junit4] 2> 399387 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.CorePropertiesLocator Config-defined core root directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores
[junit4] 2> 399387 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.CoreContainer New CoreContainer 1238201266
[junit4] 2> 399387 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.CoreContainer Loading cores into CoreContainer
[instanceDir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001]
[junit4] 2> 399387 WARN
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.CoreContainer Couldn't add files from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/lib
to classpath:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/lib
[junit4] 2> 399387 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
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> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.u.UpdateShardHandler Creating UpdateShardHandler HTTP client with params:
socketTimeout=340000&connTimeout=45000&retry=true
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.l.LogWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.l.LogWatcher Registering Log Listener [Log4j
(org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:35758/solr
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.ZkController zkHost includes chroot
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 399388 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 399389 INFO (zkCallback-296-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@42bdfde4
name:ZooKeeperConnection Watcher:127.0.0.1:35758 got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 399390 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 399390 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkACLProvider
[junit4] 2> 399391 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ConnectionManager Waiting for
client to connect to ZooKeeper
[junit4] 2> 399392 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@68606dac
name:ZooKeeperConnection Watcher:127.0.0.1:35758/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 399392 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ConnectionManager Client is
connected to ZooKeeper
[junit4] 2> 399393 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue
[junit4] 2> 399395 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-queue-work
[junit4] 2> 399396 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-running
[junit4] 2> 399397 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-completed
[junit4] 2> 399398 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/collection-map-failure
[junit4] 2> 399399 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath: /live_nodes
[junit4] 2> 399399 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath: /aliases.json
[junit4] 2> 399400 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/clusterstate.json
[junit4] 2> 399400 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/security.json
[junit4] 2> 399401 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ZkStateReader Updating cluster
state from ZooKeeper...
[junit4] 2> 399401 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (0)
[junit4] 2> 399410 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect
[junit4] 2> 399410 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/election
[junit4] 2> 399411 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 399411 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.LeaderElector Joined leadership
election with path:
/overseer_elect/election/95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000
[junit4] 2> 399411 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.OverseerElectionContext I am going to
be the leader 127.0.0.1:58402_lfzr%2Fwf
[junit4] 2> 399411 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer_elect/leader
[junit4] 2> 399412 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.Overseer Overseer
(id=95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000) starting
[junit4] 2> 399413 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/overseer/queue-work
[junit4] 2> 399416 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.OverseerAutoReplicaFailoverThread
Starting OverseerAutoReplicaFailoverThread
autoReplicaFailoverWorkLoopDelay=10000
autoReplicaFailoverWaitAfterExpiration=10000
autoReplicaFailoverBadNodeExpiration=60000
[junit4] 2> 399416 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.Overseer Starting to work on the main
queue
[junit4] 2> 399417 INFO
(OverseerCollectionConfigSetProcessor-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.OverseerTaskProcessor Process
current queue of overseer operations
[junit4] 2> 399424 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:58402_lfzr%2Fwf
[junit4] 2> 399424 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.SolrZkClient makePath:
/live_nodes/127.0.0.1:58402_lfzr%2Fwf
[junit4] 2> 399429 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ZkStateReader A live node change:
[WatchedEvent state:SyncConnected type:NodeChildrenChanged path:/live_nodes],
has occurred - updating... (live nodes size: [0])
[junit4] 2> 399429 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (0) -> (1)
[junit4] 2> 399432 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.c.ZkStateReader Updated live nodes
from ZooKeeper... (1) -> (1)
[junit4] 2> 399433 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CoreContainer Security conf doesn't
exist. Skipping setup for authorization module.
[junit4] 2> 399433 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CoreContainer No authentication
plugin used.
[junit4] 2> 399434 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CorePropertiesLocator Looking for
core definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores
[junit4] 2> 399435 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CoreDescriptor Created
CoreDescriptor: {name=collection1, config=solrconfig.xml, transient=false,
schema=schema.xml, loadOnStartup=true, configSetProperties=configsetprops.json,
collection=control_collection, coreNodeName=, dataDir=data/, shard=}
[junit4] 2> 399436 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CorePropertiesLocator Found core
collection1 in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores/collection1
[junit4] 2> 399436 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.CorePropertiesLocator Found 1 core
definitions
[junit4] 2> 399436 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController publishing state=down
[junit4] 2> 399436 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController numShards not found on descriptor - reading it from system
property
[junit4] 2> 399438 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController look for our core node name
[junit4] 2> 399439 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.s.SolrDispatchFilter
user.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 399439 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74])
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.s.SolrDispatchFilter
SolrDispatchFilter.init() done
[junit4] 2> 399439 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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:58402/lfzr/wf";,
[junit4] 2> "node_name":"127.0.0.1:58402_lfzr%2Fwf",
[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> 399439 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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:58402/lfzr/wf";,
[junit4] 2> "node_name":"127.0.0.1:58402_lfzr%2Fwf",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"down",
[junit4] 2> "shard":null,
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 399439 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.o.ClusterStateMutator building a new
cName: control_collection
[junit4] 2> 399440 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] o.a.s.c.o.ReplicaMutator Assigning new node
to shard shard=shard1
[junit4] 2> 399441 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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> 400441 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController waiting to find shard id in clusterstate for collection1
[junit4] 2> 400441 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController Check for collection zkNode:control_collection
[junit4] 2> 400441 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ZkController Collection zkNode exists
[junit4] 2> 400441 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader Load collection config from:
[/collections/control_collection]
[junit4] 2> 400442 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.c.ZkStateReader path=[/collections/control_collection]
[configName]=[conf1] specified config exists in ZooKeeper
[junit4] 2> 400442 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader new SolrResourceLoader for directory:
'/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores/collection1'
[junit4] 2> 400442 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 400442 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrResourceLoader solr home defaulted to 'solr/' (could not find
system property or JNDI)
[junit4] 2> 400443 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.Config loaded config solrconfig.xml with version 0
[junit4] 2> 400451 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrConfig current version of requestparams : -1
[junit4] 2> 400455 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 6.0.0
[junit4] 2> 400463 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.SolrConfig Loaded SolrConfig: solrconfig.xml
[junit4] 2> 400467 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.IndexSchema [collection1] Schema name=test
[junit4] 2> 400647 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Initialized with
rates=open-exchange-rates.json, refreshInterval=1440.
[junit4] 2> 400651 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.IndexSchema default search field in schema is text
[junit4] 2> 400652 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.IndexSchema unique key field: id
[junit4] 2> 400664 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 400665 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.FileExchangeRateProvider Reloading exchange rates from file currency.xml
[junit4] 2> 400667 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 400667 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.s.OpenExchangeRatesOrgProvider Reloading exchange rates from
open-exchange-rates.json
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.ConfigSetProperties Did not find ConfigSet properties, assuming default
properties: Can't find resource 'configsetprops.json' in classpath or
'/configs/conf1',
cwd=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J1
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection x:collection1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from
collection control_collection
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore org.apache.solr.core.HdfsDirectoryFactory
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory
solr.hdfs.home=hdfs://localhost:40890/solr_hdfs_home
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory Solr Kerberos Authentication
disabled
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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-6.0/solr/build/solr-core/test/J1/temp/solr.cloud.hdfs.HdfsCollectionsAPIDistributedZkTest_C85C326321D2AD74-001/control-001/cores/collection1],
dataDir=[hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/]
[junit4] 2> 400668 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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@1758f18
[junit4] 2> 400669 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 400699 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data
[junit4] 2> 400704 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore New index directory detected: old=null
new=hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index/
[junit4] 2> 400712 WARN
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Solr index directory
'hdfs:/localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index'
doesn't exist. Creating new index...
[junit4] 2> 400712 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.HdfsDirectoryFactory creating directory factory for path
hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 400731 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CachingDirectoryFactory return new directory for
hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index
[junit4] 2> 400731 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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=20, maxMergeAtOnceExplicit=46, maxMergedSegmentMB=33.728515625,
floorSegmentMB=1.91796875, forceMergeDeletesPctAllowed=20.174584174264737,
segmentsPerTier=10.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.718067646397911
[junit4] 2> 400823 INFO (IPC Server handler 0 on 40890) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:37053 is
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-d4c26d8a-154d-4c8e-acc0-9f6eb5c7a465:NORMAL:127.0.0.1:34820|RBW],
ReplicaUnderConstruction[[DISK]DS-5c88031e-1186-4e6e-bc50-7fe485ae3fa1:NORMAL:127.0.0.1:37053|RBW]]}
size 0
[junit4] 2> 400833 INFO (IPC Server handler 2 on 40890) [ ]
BlockStateChange BLOCK* addStoredBlock: blockMap updated: 127.0.0.1:34820 is
added to blk_1073741825_1001{blockUCState=UNDER_CONSTRUCTION,
primaryNodeIndex=-1,
replicas=[ReplicaUnderConstruction[[DISK]DS-5c88031e-1186-4e6e-bc50-7fe485ae3fa1:NORMAL:127.0.0.1:37053|RBW],
ReplicaUnderConstruction[[DISK]DS-6a81d2ca-cf6d-44a7-997f-13a27204d00c:NORMAL:127.0.0.1:34820|FINALIZED]]}
size 0
[junit4] 2> 400835 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onCommit: commits:
num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@78363a06;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 400835 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "nodistrib"
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "dedupe"
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe"
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain creating
updateRequestProcessorChain "stored_sig"
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.p.UpdateRequestProcessorChain inserting
DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig"
[junit4] 2> 400840 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400841 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400841 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400841 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400841 WARN
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler
{type = requestHandler,name = /dump,class = DumpRequestHandler,args =
{defaults={a=A,b=B}}}
[junit4] 2> 400850 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 400851 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 400857 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 400858 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.l.XMLLoader xsltCacheLifetimeSeconds=60
[junit4] 2> 400865 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.RequestHandlers Registered paths:
/admin/mbeans,standard,/dump,/update/csv,/sql,/update/json/docs,/admin/luke,/export,/admin/segments,/get,/admin/system,/replication,/admin/properties,/config,/stream,/schema,/admin/plugins,/admin/logging,/update/json,/admin/ping,/admin/threads,/update,/admin/file
[junit4] 2> 400865 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400869 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 400869 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.HdfsUpdateLog Initializing HdfsUpdateLog: dataDir=
defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10
tlogDfsReplication=2
[junit4] 2> 400877 INFO
(OldIndexDirectoryCleanupThreadForCore-collection1)
[n:127.0.0.1:58402_lfzr%2Fwf 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:40890/solr_hdfs_home/control_collection/core_node1/data/
[junit4] 2> 400909 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 400909 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 400934 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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=45, maxMergeAtOnceExplicit=30, maxMergedSegmentMB=3.9990234375,
floorSegmentMB=1.4775390625, forceMergeDeletesPctAllowed=13.237570672122715,
segmentsPerTier=43.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0
[junit4] 2> 401250 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy SolrDeletionPolicy.onInit: commits:
num=1
[junit4] 2>
commit{dir=NRTCachingDirectory(HdfsDirectory@hdfs://localhost:40890/solr_hdfs_home/control_collection/core_node1/data/index
lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@78363a06;
maxCacheMB=192.0 maxMergeSizeMB=16.0),segFN=segments_1,generation=1}
[junit4] 2> 401250 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrDeletionPolicy newest commit generation = 1
[junit4] 2> 401250 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.s.SolrIndexSearcher Opening
[Searcher@7095e319[collection1] main]
[junit4] 2> 401250 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401257 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401257 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401261 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO
with znodeBase: /configs/conf1
[junit4] 2> 401261 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing RestManager with initArgs: {}
[junit4] 2> 401261 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401265 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401265 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401265 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.r.RestManager Initializing 0 registered ManagedResources
[junit4] 2> 401265 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf 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 1530553776387129344
[junit4] 2> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.u.UpdateLog Took 0.0ms to seed version buckets with
highest version 1530553776387129344
[junit4] 2> 401272 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController watch zkdir /configs/conf1
[junit4] 2> 401272 INFO
(searcherExecutor-795-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7095e319[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 401273 INFO
(coreLoadExecutor-793-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.CoreContainer registering core: collection1
[junit4] 2> 401274 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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:58402/lfzr/wf collection:control_collection
shard:shard1
[junit4] 2> 401274 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401281 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.LeaderElector Joined leadership election with path:
/collections/control_collection/leader_elect/shard1/election/95659610859438086-core_node1-n_0000000000
[junit4] 2> 401281 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Running the leader process
for shard=shard1 and weAreReplacement=false and leaderVoteWait=180000
[junit4] 2> 401282 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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> 401283 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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> 401284 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 401284 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401284 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:58402/lfzr/wf/collection1/
[junit4] 2> 401284 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 401284 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:58402/lfzr/wf/collection1/
has no replicas
[junit4] 2> 401289 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.SolrZkClient makePath:
/collections/control_collection/leaders/shard1
[junit4] 2> 401290 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContextBase Creating leader
registration node /collections/control_collection/leaders/shard1/leader after
winning as
/collections/control_collection/leader_elect/shard1/election/95659610859438086-core_node1-n_0000000000
[junit4] 2> 401291 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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:58402/lfzr/wf";,
[junit4] 2> "core":"collection1",
[junit4] 2> "state":"active"} current state version: 2
[junit4] 2> 401297 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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:58402/lfzr/wf/collection1/ shard1
[junit4] 2> 401399 INFO
(zkCallback-297-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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> 401400 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController We are
http://127.0.0.1:58402/lfzr/wf/collection1/ and leader is
http://127.0.0.1:58402/lfzr/wf/collection1/
[junit4] 2> 401400 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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:58402/lfzr/wf
[junit4] 2> 401401 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 401401 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.ZkController publishing state=active
[junit4] 2> 401401 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf 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> 401401 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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:58402/lfzr/wf";,
[junit4] 2> "node_name":"127.0.0.1:58402_lfzr%2Fwf",
[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> 401402 INFO
(OverseerStateUpdate-95659610859438086-127.0.0.1:58402_lfzr%2Fwf-n_0000000000)
[n:127.0.0.1:58402_lfzr%2Fwf ] 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:58402/lfzr/wf";,
[junit4] 2> "node_name":"127.0.0.1:58402_lfzr%2Fwf",
[junit4] 2> "numShards":"1",
[junit4] 2> "state":"active",
[junit4] 2> "shard":"shard1",
[junit4] 2> "collection":"control_collection",
[junit4] 2> "operation":"state"}
[junit4] 2> 401403 INFO
(coreZkRegister-788-thread-1-processing-n:127.0.0.1:58402_lfzr%2Fwf
x:collection1 s:shard1 c:control_collection r:core_node1)
[n:127.0.0.1:58402_lfzr%2Fwf c:control_collection s:shard1 r:core_node1
x:collection1] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1)
-> (1)
[junit4] 2> 401440 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using default ZkCredentialsProvider
[junit4] 2> 401449 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 401455 INFO (zkCallback-299-thread-1) [ ]
o.a.s.c.c.ConnectionManager Watcher
org.apache.solr.common.cloud.ConnectionManager@3525a935
name:ZooKeeperConnection Watcher:127.0.0.1:35758/solr got event WatchedEvent
state:SyncConnected type:None path:null path:null type:None
[junit4] 2> 401455 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 401455 INFO
(TEST-HdfsCollectionsAPIDistributedZkTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.c.SolrZkClient Using
[...truncated too long message...]
e1 x:collection1] o.a.s.c.CachingDirectoryFactory looking to close
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.client.solrj.ConnectionReuseTest_C85C326321D2AD74-001/shard-1-001/cores/collection1/data
[CachedDir<<refCount=0;path=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.client.solrj.ConnectionReuseTest_C85C326321D2AD74-001/shard-1-001/cores/collection1/data;done=false>>]
[junit4] 2> 4811699 INFO (coreCloseExecutor-7502-thread-1)
[n:127.0.0.1:42290_ c:collection1 s:shard1 r:core_node1 x:collection1]
o.a.s.c.CachingDirectoryFactory Closing directory:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.client.solrj.ConnectionReuseTest_C85C326321D2AD74-001/shard-1-001/cores/collection1/data
[junit4] 2> 4811699 INFO
(TEST-ConnectionReuseTest.test-seed#[C85C326321D2AD74]) [ ] o.a.s.c.Overseer
Overseer (id=95659893199601673-127.0.0.1:42290_-n_0000000001) closing
[junit4] 2> 4811700 INFO
(OverseerStateUpdate-95659893199601673-127.0.0.1:42290_-n_0000000001)
[n:127.0.0.1:42290_ ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:42290_
[junit4] 2> 4811701 INFO
(zkCallback-2710-thread-2-processing-n:127.0.0.1:42290_) [n:127.0.0.1:42290_
] o.a.s.c.c.ZkStateReader A live node change: [WatchedEvent state:SyncConnected
type:NodeChildrenChanged path:/live_nodes], has occurred - updating... (live
nodes size: [1])
[junit4] 2> 4811701 INFO
(zkCallback-2710-thread-3-processing-n:127.0.0.1:42290_) [n:127.0.0.1:42290_
] 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> 4813219 WARN
(zkCallback-2710-thread-2-processing-n:127.0.0.1:42290_) [n:127.0.0.1:42290_
] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to
ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 4813219 WARN
(zkCallback-2710-thread-3-processing-n:127.0.0.1:42290_) [n:127.0.0.1:42290_
] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to
ZK: [KeeperErrorCode = Session expired for /clusterstate.json]
[junit4] 2> 4813222 INFO
(TEST-ConnectionReuseTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.ServerConnector Stopped
ServerConnector@29b1e8d5{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 4813223 INFO
(TEST-ConnectionReuseTest.test-seed#[C85C326321D2AD74]) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@2369557b{/,null,UNAVAILABLE}
[junit4] 2> 4813225 INFO
(TEST-ConnectionReuseTest.test-seed#[C85C326321D2AD74]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:54979 54979
[junit4] 2> 4813412 INFO (Thread-6690) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:54979 54979
[junit4] 2> 4813412 WARN (Thread-6690) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/aliases.json
[junit4] 2> 2 /solr/security.json
[junit4] 2> 2 /solr/configs/conf1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 3 /solr/live_nodes
[junit4] 2> 3 /solr/collections
[junit4] 2> 2 /solr/overseer/queue
[junit4] 2> 2 /solr/overseer/collection-queue-work
[junit4] 2>
[junit4] 2> NOTE: download the large Jenkins line-docs file by running
'ant get-jenkins-line-docs' in the lucene directory.
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=ConnectionReuseTest
-Dtests.method=test -Dtests.seed=C85C326321D2AD74 -Dtests.multiplier=2
-Dtests.nightly=true -Dtests.slow=true
-Dtests.linedocsfile=/x1/jenkins/lucene-data/enwiki.random.lines.txt
-Dtests.locale=uk-UA -Dtests.timezone=America/Rankin_Inlet -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[junit4] FAILURE 106s J2 | ConnectionReuseTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: We expected all
communication via streaming client to use one connection! expected=266 got=262
[junit4] > at
__randomizedtesting.SeedInfo.seed([C85C326321D2AD74:40080DB98F2EC08C]:0)
[junit4] > at
org.apache.solr.client.solrj.ConnectionReuseTest.test(ConnectionReuseTest.java:150)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:992)
[junit4] > at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:967)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 4813427 INFO
(SUITE-ConnectionReuseTest-seed#[C85C326321D2AD74]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build/solr-core/test/J2/temp/solr.client.solrj.ConnectionReuseTest_C85C326321D2AD74-001
[junit4] 2> NOTE: test params are:
codec=DummyCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=DUMMY,
chunkSize=17884, maxDocsPerChunk=166, blockSize=9),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=DUMMY,
chunkSize=17884, blockSize=9)),
sim=RandomSimilarity(queryNorm=true,coord=crazy): {}, locale=uk-UA,
timezone=America/Rankin_Inlet
[junit4] 2> NOTE: Linux 3.13.0-52-generic amd64/Oracle Corporation
1.8.0_74 (64-bit)/cpus=4,threads=2,free=95312208,total=461897728
[junit4] 2> NOTE: All tests run in this JVM: [HdfsLockFactoryTest,
SolrCoreCheckLockOnStartupTest, HdfsRestartWhileUpdatingTest,
HdfsChaosMonkeyNothingIsSafeTest, BinaryUpdateRequestHandlerTest, OverseerTest,
FieldMutatingUpdateProcessorTest, TestSolrConfigHandlerCloud,
TestIndexSearcher, UnloadDistributedZkTest, TestComplexPhraseQParserPlugin,
ExitableDirectoryReaderTest, MergeStrategyTest, CdcrUpdateLogTest,
TestPerFieldSimilarityWithDefaultOverride, DeleteStatusTest,
TestSolrCLIRunExample, SuggesterTest, DistributedQueryComponentCustomSortTest,
TestXIncludeConfig, TestSchemaManager, TestReloadDeadlock, UpdateParamsTest,
TestSerializedLuceneMatchVersion, TestFilteredDocIdSet, SuggesterTSTTest,
AutoCommitTest, SolrCloudExampleTest, TestExceedMaxTermLength,
DocValuesMultiTest, FacetPivotSmallTest, TestReloadAndDeleteDocs,
TestUniqueKeyFieldResource, TestJmxMonitoredMap, BadIndexSchemaTest,
BigEndianAscendingWordSerializerTest, TestSolrQueryParser,
AddSchemaFieldsUpdateProcessorFactoryTest, PluginInfoTest,
TestPostingsSolrHighlighter, TestDistribIDF, RegexBoostProcessorTest,
BadCopyFieldTest, TestUtils, DistribJoinFromCollectionTest,
TestRequestStatusCollectionAPI, TestAuthorizationFramework, BlockDirectoryTest,
OverseerTaskQueueTest, XmlUpdateRequestHandlerTest, NoCacheHeaderTest,
CurrencyFieldXmlFileTest, TestSha256AuthenticationProvider,
BlockJoinFacetRandomTest, TestPerFieldSimilarity, TestSuggestSpellingConverter,
CoreAdminRequestStatusTest, SimpleFacetsTest, TestSearchPerf,
CdcrRequestHandlerTest, PrimitiveFieldTypeTest, TestLRUStatsCache,
CollectionsAPISolrJTest, TestConfigSetsAPIZkFailure, DistanceUnitsTest,
TestCoreDiscovery, TestSolrCloudWithKerberosAlt, TestDFISimilarityFactory,
TestConfigSets, TestSweetSpotSimilarityFactory, TestGroupingSearch,
DocValuesMissingTest, TestRebalanceLeaders, TestMaxScoreQueryParser,
TestFreeTextSuggestions, DebugComponentTest, DirectSolrConnectionTest,
TestScoreJoinQPNoScore, VMParamsZkACLAndCredentialsProvidersTest,
CollectionStateFormat2Test, TestDownShardTolerantSearch,
LeaderInitiatedRecoveryOnCommitTest, TestPivotHelperCode, TestSchemaResource,
TestExtendedDismaxParser, TestSortingResponseWriter, SuggestComponentTest,
TestPHPSerializedResponseWriter, SliceStateTest, RecoveryZkTest,
ForceLeaderTest, TestReqParamsAPI, BasicDistributedZkTest,
ChaosMonkeySafeLeaderTest, BasicDistributedZk2Test,
CollectionsAPIDistributedZkTest, OpenCloseCoreStressTest,
TestReplicationHandler, SolrTestCaseJ4Test, TestCrossCoreJoin,
TestCursorMarkWithoutUniqueKey, TestDistributedMissingSort,
TestHighlightDedupGrouping, TestSimpleTrackingShardHandler, TestTolerantSearch,
ConnectionReuseTest]
[junit4] Completed [437/579 (3!)] on J2 in 106.19s, 1 test, 1 failure <<<
FAILURES!
[...truncated 473 lines...]
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:747:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:684:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/build.xml:59:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/build.xml:233:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/solr/common-build.xml:527:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1457:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-6.0/lucene/common-build.xml:1014:
There were test failures: 579 suites (10 ignored), 2309 tests, 2 errors, 1
failure, 31 ignored (16 assumptions) [seed: C85C326321D2AD74]
Total time: 290 minutes 48 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 - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org
For additional commands, e-mail: dev-h...@lucene.apache.org
