Build: https://builds.apache.org/job/Lucene-Solr-NightlyTests-master/1254/
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest: 1) Thread[id=3211,
name=qtp510760146-3211, state=TIMED_WAITING,
group=TGRP-ChaosMonkeyNothingIsSafeTest] at
java.lang.Throwable.fillInStackTrace(Native Method) at
java.lang.Throwable.fillInStackTrace(Throwable.java:783) at
java.lang.Throwable.<init>(Throwable.java:250) at
java.lang.Exception.<init>(Exception.java:54) at
java.lang.InterruptedException.<init>(InterruptedException.java:57) at
java.lang.Object.wait(Native Method) at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528) at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534) at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest:
1) Thread[id=3211, name=qtp510760146-3211, state=TIMED_WAITING,
group=TGRP-ChaosMonkeyNothingIsSafeTest]
at java.lang.Throwable.fillInStackTrace(Native Method)
at java.lang.Throwable.fillInStackTrace(Throwable.java:783)
at java.lang.Throwable.<init>(Throwable.java:250)
at java.lang.Exception.<init>(Exception.java:54)
at java.lang.InterruptedException.<init>(InterruptedException.java:57)
at java.lang.Object.wait(Native Method)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([FBBC37A894D050A5]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
There are still zombie threads that couldn't be terminated: 1)
Thread[id=3211, name=qtp510760146-3211, state=RUNNABLE,
group=TGRP-ChaosMonkeyNothingIsSafeTest] at
java.lang.Object.wait(Native Method) at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528) at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534) at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320) at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
1) Thread[id=3211, name=qtp510760146-3211, state=RUNNABLE,
group=TGRP-ChaosMonkeyNothingIsSafeTest]
at java.lang.Object.wait(Native Method)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
at org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
at org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
at org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
at org.eclipse.jetty.server.Server.handle(Server.java:534)
at org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
at org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([FBBC37A894D050A5]:0)
Build Log:
[...truncated 11676 lines...]
[junit4] Suite: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/init-core-data-001
[junit4] 2> 510755 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[FBBC37A894D050A5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields
[junit4] 2> 510756 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[FBBC37A894D050A5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl=https://issues.apache.org/jira/browse/SOLR-5776)
[junit4] 2> 510756 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[FBBC37A894D050A5]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 510758 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 510758 INFO (Thread-959) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 510758 INFO (Thread-959) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 510858 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkTestServer start zk server on port:42401
[junit4] 2> 510869 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 510871 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 510872 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 510873 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 510874 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 510875 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 510876 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 510877 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 510878 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 510879 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 510880 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractZkTestCase put
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 510947 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/cores/collection1
[junit4] 2> 510948 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 510950 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@290ab9c3{/,null,AVAILABLE}
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3fb5071a{HTTP/1.1,[http/1.1]}{127.0.0.1:60403}
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server Started @515010ms
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/tempDir-001/control/data,
hostContext=/, hostPort=60403,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/cores}
[junit4] 2> 510954 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 510954 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-04T19:01:26.547Z
[junit4] 2> 510957 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 510957 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/solr.xml
[junit4] 2> 510968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42401/solr
[junit4] 2> 510985 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 510988 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.OverseerElectionContext I am going to be the
leader 127.0.0.1:60403_
[junit4] 2> 510989 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.Overseer Overseer
(id=97560434203230212-127.0.0.1:60403_-n_0000000000) starting
[junit4] 2> 510994 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:60403_
[junit4] 2> 511000 INFO
(zkCallback-395-thread-1-processing-n:127.0.0.1:60403_) [n:127.0.0.1:60403_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 511050 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/cores
[junit4] 2> 511050 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:60403_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 511058 INFO
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard1
[junit4] 2> 512085 WARN
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.c.Config
Beginning with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory>
instead.
[junit4] 2> 512086 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 7.0.0
[junit4] 2> 512096 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 512143 WARN
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 512144 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 512159 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection
control_collection
[junit4] 2> 512159 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/control-001/cores/collection1/data/]
[junit4] 2> 512160 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.c.JmxMonitoredMap JMX monitoring is enabled. Adding Solr mbeans to JMX
Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3d46f8f2
[junit4] 2> 512161 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@10ac6ad6
[junit4] 2> 512173 WARN
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.c.RequestHandlers INVALID paramSet a in requestHandler {type =
requestHandler,name = /dump,class = DumpRequestHandler,attributes =
{initParams=a, name=/dump, class=DumpRequestHandler},args =
{defaults={a=A,b=B}}}
[junit4] 2> 512210 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 512210 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 512211 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.u.CommitTracker
Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 512211 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 512212 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=24, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8567664016904397]
[junit4] 2> 512213 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1d5d7625[collection1] main]
[junit4] 2> 512214 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 512214 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 512214 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 512215 INFO
(coreLoadExecutor-1336-thread-1-processing-n:127.0.0.1:60403_)
[n:127.0.0.1:60403_ c:control_collection x:collection1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1560966948777361408
[junit4] 2> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas
found to continue.
[junit4] 2> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ 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> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:60403/collection1/
[junit4] 2> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync
replicas to me
[junit4] 2> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.SyncStrategy
http://127.0.0.1:60403/collection1/ has no replicas
[junit4] 2> 512220 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ShardLeaderElectionContext Found all
replicas participating in election, clear LIR
[junit4] 2> 512228 INFO
(searcherExecutor-1337-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@1d5d7625[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 512242 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ 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:60403/collection1/ shard1
[junit4] 2> 512353 INFO
(coreZkRegister-1329-thread-1-processing-n:127.0.0.1:60403_ x:collection1
c:control_collection) [n:127.0.0.1:60403_ c:control_collection s:shard1
r:core_node1 x:collection1] o.a.s.c.ZkController I am the leader, no recovery
necessary
[junit4] 2> 512609 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 512609 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42401/solr ready
[junit4] 2> 512609 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 512609 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating collection1 with stateFormat=2
[junit4] 2> 512680 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/cores/collection1
[junit4] 2> 512681 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001
[junit4] 2> 512681 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 512683 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6ba667cc{/,null,AVAILABLE}
[junit4] 2> 512683 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@28517ea9{HTTP/1.1,[http/1.1]}{127.0.0.1:49811}
[junit4] 2> 512683 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server Started @516740ms
[junit4] 2> 512683 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/tempDir-001/jetty1,
solrconfig=solrconfig.xml, hostContext=/, hostPort=49811,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/cores}
[junit4] 2> 512684 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 512685 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 512685 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 512685 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 512685 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-04T19:01:28.278Z
[junit4] 2> 512687 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 512688 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/solr.xml
[junit4] 2> 512693 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42401/solr
[junit4] 2> 512708 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:49811_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 512709 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:49811_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 512711 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:49811_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:49811_
[junit4] 2> 512714 INFO (zkCallback-399-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 512714 INFO
(zkCallback-395-thread-4-processing-n:127.0.0.1:60403_) [n:127.0.0.1:60403_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 512735 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 512806 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:49811_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/cores
[junit4] 2> 512806 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:49811_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 512811 INFO
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 512913 WARN
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.Overseer Bad version writing to ZK using
compare-and-set, will force refresh cluster state: KeeperErrorCode = BadVersion
for /collections/collection1/state.json
[junit4] 2> 512917 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 512919 INFO
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard2
[junit4] 2> 512920 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 513820 WARN
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 513821 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 513831 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 513885 WARN
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 513886 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 513901 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 513902 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-1-001/cores/collection1/data/]
[junit4] 2> 513902 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d46f8f2
[junit4] 2> 513903 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@74f4c1b6
[junit4] 2> 513911 WARN
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 513936 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 513936 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 513937 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommited for 15000ms;
[junit4] 2> 513937 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 513938 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=24,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8567664016904397]
[junit4] 2> 513938 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@424b04d7[collection1] main]
[junit4] 2> 513939 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 513939 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 513939 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 513940 INFO
(searcherExecutor-1348-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@424b04d7[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 513940 INFO
(coreLoadExecutor-1347-thread-1-processing-n:127.0.0.1:49811_)
[n:127.0.0.1:49811_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1560966950586155008
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:49811/collection1/
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:49811/collection1/ has no
replicas
[junit4] 2> 513945 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 513948 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:49811/collection1/ shard2
[junit4] 2> 514049 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 514099 INFO
(coreZkRegister-1342-thread-1-processing-n:127.0.0.1:49811_ x:collection1
c:collection1) [n:127.0.0.1:49811_ c:collection1 s:shard2 r:core_node1
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 514201 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [2])
[junit4] 2> 514428 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/cores/collection1
[junit4] 2> 514429 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001
[junit4] 2> 514429 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 514430 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3615d08b{/,null,AVAILABLE}
[junit4] 2> 514430 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@2dd0c880{HTTP/1.1,[http/1.1]}{127.0.0.1:57920}
[junit4] 2> 514430 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server Started @518487ms
[junit4] 2> 514435 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/tempDir-001/jetty2,
solrconfig=solrconfig.xml, hostContext=/, hostPort=57920,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/cores}
[junit4] 2> 514435 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 514435 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 514435 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 514435 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 514435 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-04T19:01:30.028Z
[junit4] 2> 514437 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 514437 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/solr.xml
[junit4] 2> 514443 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42401/solr
[junit4] 2> 514449 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57920_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 514450 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57920_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 514451 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57920_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57920_
[junit4] 2> 514452 INFO (zkCallback-399-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 514452 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 514453 INFO
(zkCallback-395-thread-5-processing-n:127.0.0.1:60403_) [n:127.0.0.1:60403_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 514465 INFO
(zkCallback-411-thread-1-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 514522 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57920_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/cores
[junit4] 2> 514522 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57920_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 514523 INFO
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard3
[junit4] 2> 514625 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 514625 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 515534 WARN
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 515535 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 515557 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 515603 WARN
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 515604 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 515616 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 515617 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-2-001/cores/collection1/data/]
[junit4] 2> 515617 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d46f8f2
[junit4] 2> 515618 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@5d576112
[junit4] 2> 515626 WARN
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 515652 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 515652 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 515653 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommited for 15000ms;
[junit4] 2> 515653 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 515654 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=24,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8567664016904397]
[junit4] 2> 515654 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@7add8aa8[collection1] main]
[junit4] 2> 515658 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 515658 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 515658 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 515661 INFO
(searcherExecutor-1359-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@7add8aa8[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 515662 INFO
(coreLoadExecutor-1358-thread-1-processing-n:127.0.0.1:57920_)
[n:127.0.0.1:57920_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1560966952391802880
[junit4] 2> 515667 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 515668 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 515668 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:57920/collection1/
[junit4] 2> 515668 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 515668 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:57920/collection1/ has no
replicas
[junit4] 2> 515668 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 515670 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:57920/collection1/ shard3
[junit4] 2> 515771 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 515773 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 515823 INFO
(coreZkRegister-1353-thread-1-processing-n:127.0.0.1:57920_ x:collection1
c:collection1) [n:127.0.0.1:57920_ c:collection1 s:shard3 r:core_node2
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 515927 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 515927 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [3])
[junit4] 2> 516138 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/cores/collection1
[junit4] 2> 516139 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001
[junit4] 2> 516139 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 516140 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@646ab145{/,null,AVAILABLE}
[junit4] 2> 516141 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@35643059{HTTP/1.1,[http/1.1]}{127.0.0.1:57955}
[junit4] 2> 516141 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server Started @520198ms
[junit4] 2> 516141 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/tempDir-001/jetty3,
solrconfig=solrconfig.xml, hostContext=/, hostPort=57955,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/cores}
[junit4] 2> 516141 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 516143 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 516143 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 516143 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 516143 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-04T19:01:31.736Z
[junit4] 2> 516146 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 516146 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/solr.xml
[junit4] 2> 516155 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42401/solr
[junit4] 2> 516175 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57955_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 516177 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57955_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 516178 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57955_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:57955_
[junit4] 2> 516179 INFO
(zkCallback-395-thread-5-processing-n:127.0.0.1:60403_) [n:127.0.0.1:60403_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 516180 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 516180 INFO (zkCallback-399-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 516179 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 516190 INFO
(zkCallback-417-thread-1-processing-n:127.0.0.1:57955_) [n:127.0.0.1:57955_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 516265 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57955_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/cores
[junit4] 2> 516266 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:57955_ ] o.a.s.c.CorePropertiesLocator Cores are: [collection1]
[junit4] 2> 516272 INFO
(OverseerStateUpdate-97560434203230212-127.0.0.1:60403_-n_0000000000)
[n:127.0.0.1:60403_ ] o.a.s.c.o.ReplicaMutator Assigning new node to shard
shard=shard4
[junit4] 2> 516374 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 516374 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 516374 INFO
(zkCallback-417-thread-2-processing-n:127.0.0.1:57955_) [n:127.0.0.1:57955_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517281 WARN
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.Config Beginning
with Solr 5.5, <mergePolicy> is deprecated, use <mergePolicyFactory> instead.
[junit4] 2> 517282 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.SolrConfig Using
Lucene MatchVersion: 7.0.0
[junit4] 2> 517292 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] Schema name=test
[junit4] 2> 517383 WARN
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.s.IndexSchema
[collection1] default search field in schema is text. WARNING: Deprecated,
please use 'df' on request instead.
[junit4] 2> 517384 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 517417 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.CoreContainer
Creating SolrCore 'collection1' using configuration from collection collection1
[junit4] 2> 517417 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.SolrCore
[[collection1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/cores/collection1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-3-001/cores/collection1/data/]
[junit4] 2> 517418 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.JmxMonitoredMap JMX
monitoring is enabled. Adding Solr mbeans to JMX Server:
com.sun.jmx.mbeanserver.JmxMBeanServer@3d46f8f2
[junit4] 2> 517419 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy:
org.apache.lucene.index.MockRandomMergePolicy@6e8c31af
[junit4] 2> 517426 WARN
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.c.RequestHandlers
INVALID paramSet a in requestHandler {type = requestHandler,name = /dump,class
= DumpRequestHandler,attributes = {initParams=a, name=/dump,
class=DumpRequestHandler},args = {defaults={a=A,b=B}}}
[junit4] 2> 517452 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.UpdateHandler Using
UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 517452 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 517453 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.CommitTracker Hard
AutoCommit: if uncommited for 15000ms;
[junit4] 2> 517453 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.CommitTracker Soft
AutoCommit: disabled
[junit4] 2> 517454 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.RandomMergePolicy
RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy:
[LogDocMergePolicy: minMergeSize=1000, mergeFactor=24,
maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.8567664016904397]
[junit4] 2> 517454 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.s.SolrIndexSearcher
Opening [Searcher@3d0b571[collection1] main]
[junit4] 2> 517455 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 517455 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 517455 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.h.ReplicationHandler
Commits will be reserved for 10000
[junit4] 2> 517456 INFO
(coreLoadExecutor-1369-thread-1-processing-n:127.0.0.1:57955_)
[n:127.0.0.1:57955_ c:collection1 x:collection1] o.a.s.u.UpdateLog Could not
find max version in index or recent updates, using new clock 1560966954272948224
[junit4] 2> 517456 INFO
(searcherExecutor-1370-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 x:collection1]
o.a.s.c.SolrCore [collection1] Registered new searcher
Searcher@3d0b571[collection1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to
continue.
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try
and sync
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:57955/collection1/
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.SyncStrategy http://127.0.0.1:57955/collection1/ has no
replicas
[junit4] 2> 517470 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext Found all replicas
participating in election, clear LIR
[junit4] 2> 517473 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:57955/collection1/ shard4
[junit4] 2> 517574 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517574 INFO
(zkCallback-417-thread-2-processing-n:127.0.0.1:57955_) [n:127.0.0.1:57955_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517574 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517624 INFO
(coreZkRegister-1364-thread-1-processing-n:127.0.0.1:57955_ x:collection1
c:collection1) [n:127.0.0.1:57955_ c:collection1 s:shard4 r:core_node3
x:collection1] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 517727 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517731 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517731 INFO
(zkCallback-417-thread-2-processing-n:127.0.0.1:57955_) [n:127.0.0.1:57955_
] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 517930 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.SolrTestCaseJ4 Writing core.properties file to
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-4-001/cores/collection1
[junit4] 2> 517931 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-4-001
[junit4] 2> 517933 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server jetty-9.3.14.v20161028
[junit4] 2> 517934 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@2bd73fad{/,null,AVAILABLE}
[junit4] 2> 517935 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@3b7cbe76{HTTP/1.1,[http/1.1]}{127.0.0.1:34490}
[junit4] 2> 517935 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.e.j.s.Server Started @521991ms
[junit4] 2> 517935 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties:
{solr.data.dir=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/tempDir-001/jetty4,
solrconfig=solrconfig.xml, hostContext=/, hostPort=34490,
coreRootDirectory=/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-4-001/cores}
[junit4] 2> 517935 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 517942 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 517942 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 517942 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 517942 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-03-04T19:01:33.535Z
[junit4] 2> 517976 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 517976 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/temp/solr.cloud.ChaosMonkeyNothingIsSafeTest_FBBC37A894D050A5-001/shard-4-001/solr.xml
[junit4] 2> 517982 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42401/solr
[junit4] 2> 518013 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:34490_ ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 518015 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:34490_ ] o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 518016 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:34490_ ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:34490_
[junit4] 2> 518023 INFO
(zkCallback-405-thread-2-processing-n:127.0.0.1:49811_) [n:127.0.0.1:49811_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518024 INFO
(zkCallback-411-thread-2-processing-n:127.0.0.1:57920_) [n:127.0.0.1:57920_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518024 INFO
(zkCallback-417-thread-2-processing-n:127.0.0.1:57955_) [n:127.0.0.1:57955_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518024 INFO
(zkCallback-395-thread-4-processing-n:127.0.0.1:60403_) [n:127.0.0.1:60403_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518024 INFO (zkCallback-399-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518053 INFO
(zkCallback-423-thread-1-processing-n:127.0.0.1:34490_) [n:127.0.0.1:34490_
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 518111 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[FBBC37A894D050A5])
[n:127.0.0.1:34490_ ] o.a.s.c.CorePropertiesLocator Found 1 core definitions
underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-NightlyTests-master/checkout/solr/build/solr-core/test/J1/../../../../../../../../../../../x1/jenkins/jenkins-slave/workspace/Lucene-Solr-Nig
[...truncated too long message...]
ingIsSafeTest:
[junit4] > 1) Thread[id=3211, name=qtp510760146-3211,
state=TIMED_WAITING, group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at java.lang.Throwable.fillInStackTrace(Native Method)
[junit4] > at
java.lang.Throwable.fillInStackTrace(Throwable.java:783)
[junit4] > at java.lang.Throwable.<init>(Throwable.java:250)
[junit4] > at java.lang.Exception.<init>(Exception.java:54)
[junit4] > at
java.lang.InterruptedException.<init>(InterruptedException.java:57)
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
[junit4] > at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
[junit4] > at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
[junit4] > at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
[junit4] > at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
[junit4] > at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
[junit4] > at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
[junit4] > at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
[junit4] > at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
[junit4] > at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
[junit4] > at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
[junit4] > at
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
[junit4] > at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528)
[junit4] > at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
[junit4] > at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] > at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] > at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] > at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] > at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] > at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] > at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] > at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] > at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] > at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] > at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] > at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] > at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] > at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] > at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([FBBC37A894D050A5]:0)Throwable #2:
com.carrotsearch.randomizedtesting.ThreadLeakError: There are still zombie
threads that couldn't be terminated:
[junit4] > 1) Thread[id=3211, name=qtp510760146-3211, state=RUNNABLE,
group=TGRP-ChaosMonkeyNothingIsSafeTest]
[junit4] > at java.lang.Object.wait(Native Method)
[junit4] > at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.waitForEmptyQueue(ConcurrentUpdateSolrClient.java:657)
[junit4] > at
org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrClient.blockUntilFinished(ConcurrentUpdateSolrClient.java:589)
[junit4] > at
org.apache.solr.update.StreamingSolrClients.blockUntilFinished(StreamingSolrClients.java:91)
[junit4] > at
org.apache.solr.update.SolrCmdDistributor.blockAndDoRetries(SolrCmdDistributor.java:243)
[junit4] > at
org.apache.solr.update.SolrCmdDistributor.finish(SolrCmdDistributor.java:95)
[junit4] > at
org.apache.solr.update.processor.DistributedUpdateProcessor.doFinish(DistributedUpdateProcessor.java:844)
[junit4] > at
org.apache.solr.update.processor.DistributedUpdateProcessor.finish(DistributedUpdateProcessor.java:1919)
[junit4] > at
org.apache.solr.update.processor.LogUpdateProcessorFactory$LogUpdateProcessor.finish(LogUpdateProcessorFactory.java:182)
[junit4] > at
org.apache.solr.handler.ContentStreamHandlerBase.handleRequestBody(ContentStreamHandlerBase.java:78)
[junit4] > at
org.apache.solr.handler.RequestHandlerBase.handleRequest(RequestHandlerBase.java:171)
[junit4] > at
org.apache.solr.core.SolrCore.execute(SolrCore.java:2420)
[junit4] > at
org.apache.solr.servlet.HttpSolrCall.execute(HttpSolrCall.java:722)
[junit4] > at
org.apache.solr.servlet.HttpSolrCall.call(HttpSolrCall.java:528)
[junit4] > at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:347)
[junit4] > at
org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:298)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] > at
org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:139)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1699)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:582)
[junit4] > at
org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:224)
[junit4] > at
org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1180)
[junit4] > at
org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:512)
[junit4] > at
org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:185)
[junit4] > at
org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1112)
[junit4] > at
org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:141)
[junit4] > at
org.eclipse.jetty.server.handler.gzip.GzipHandler.handle(GzipHandler.java:395)
[junit4] > at
org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:134)
[junit4] > at
org.eclipse.jetty.server.Server.handle(Server.java:534)
[junit4] > at
org.eclipse.jetty.server.HttpChannel.handle(HttpChannel.java:320)
[junit4] > at
org.eclipse.jetty.server.HttpConnection.onFillable(HttpConnection.java:251)
[junit4] > at
org.eclipse.jetty.io.AbstractConnection$ReadCallback.succeeded(AbstractConnection.java:273)
[junit4] > at
org.eclipse.jetty.io.FillInterest.fillable(FillInterest.java:95)
[junit4] > at
org.eclipse.jetty.io.SelectChannelEndPoint$2.run(SelectChannelEndPoint.java:93)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.executeProduceConsume(ExecuteProduceConsume.java:303)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.produceConsume(ExecuteProduceConsume.java:148)
[junit4] > at
org.eclipse.jetty.util.thread.strategy.ExecuteProduceConsume.run(ExecuteProduceConsume.java:136)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:671)
[junit4] > at
org.eclipse.jetty.util.thread.QueuedThreadPool$2.run(QueuedThreadPool.java:589)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([FBBC37A894D050A5]:0)
[junit4] Completed [117/693 (1!)] on J1 in 124.59s, 1 test, 2 errors <<<
FAILURES!
[...truncated 64349 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
