Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6866/
Java: 64bit/jdk-9-ea+181 -XX:+UseCompressedOops -XX:+UseSerialGC
--illegal-access=deny
3 tests failed.
FAILED: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest.test
Error Message:
Test abandoned because suite timeout was reached.
Stack Trace:
java.lang.Exception: Test abandoned because suite timeout was reached.
at __randomizedtesting.SeedInfo.seed([506547354F7EF2A5]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
Error Message:
Suite timeout exceeded (>= 7200000 msec).
Stack Trace:
java.lang.Exception: Suite timeout exceeded (>= 7200000 msec).
at __randomizedtesting.SeedInfo.seed([506547354F7EF2A5]:0)
FAILED:
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testExecutorStream
Error Message:
Error from server at http://127.0.0.1:54280/solr/mainCorpus_shard2_replica_n2:
Expected mime type application/octet-stream but got text/html. <html> <head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title> </head> <body> <h2>HTTP ERROR: 404</h2> <p>Problem
accessing /solr/mainCorpus_shard2_replica_n2/update. Reason: <pre> Can not
find: /solr/mainCorpus_shard2_replica_n2/update</pre></p> <hr /><a
href="http://eclipse.org/jetty";>Powered by Jetty:// 9.3.20.v20170531</a><hr/>
</body> </html>
Stack Trace:
org.apache.solr.client.solrj.impl.CloudSolrClient$RouteException: Error from
server at http://127.0.0.1:54280/solr/mainCorpus_shard2_replica_n2: Expected
mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /solr/mainCorpus_shard2_replica_n2/update. Reason:
<pre> Can not find: /solr/mainCorpus_shard2_replica_n2/update</pre></p>
<hr /><a href="http://eclipse.org/jetty";>Powered by Jetty://
9.3.20.v20170531</a><hr/>
</body>
</html>
at
__randomizedtesting.SeedInfo.seed([48DD08D112D3AD0F:6A1D892A31B9871F]:0)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.directUpdate(CloudSolrClient.java:539)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.sendRequest(CloudSolrClient.java:993)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.requestWithRetryOnStaleState(CloudSolrClient.java:862)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.request(CloudSolrClient.java:793)
at
org.apache.solr.client.solrj.SolrRequest.process(SolrRequest.java:178)
at
org.apache.solr.client.solrj.request.UpdateRequest.commit(UpdateRequest.java:233)
at
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testExecutorStream(StreamExpressionTest.java:6823)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.base/java.lang.reflect.Method.invoke(Method.java:564)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:844)
Caused by:
org.apache.solr.client.solrj.impl.HttpSolrClient$RemoteSolrException: Error
from server at http://127.0.0.1:54280/solr/mainCorpus_shard2_replica_n2:
Expected mime type application/octet-stream but got text/html. <html>
<head>
<meta http-equiv="Content-Type" content="text/html;charset=ISO-8859-1"/>
<title>Error 404 </title>
</head>
<body>
<h2>HTTP ERROR: 404</h2>
<p>Problem accessing /solr/mainCorpus_shard2_replica_n2/update. Reason:
<pre> Can not find: /solr/mainCorpus_shard2_replica_n2/update</pre></p>
<hr /><a href="http://eclipse.org/jetty";>Powered by Jetty://
9.3.20.v20170531</a><hr/>
</body>
</html>
at
org.apache.solr.client.solrj.impl.HttpSolrClient.executeMethod(HttpSolrClient.java:591)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:253)
at
org.apache.solr.client.solrj.impl.HttpSolrClient.request(HttpSolrClient.java:242)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.doRequest(LBHttpSolrClient.java:483)
at
org.apache.solr.client.solrj.impl.LBHttpSolrClient.request(LBHttpSolrClient.java:413)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.lambda$directUpdate$0(CloudSolrClient.java:516)
at java.base/java.util.concurrent.FutureTask.run(FutureTask.java:264)
at
org.apache.solr.common.util.ExecutorUtil$MDCAwareThreadPoolExecutor.lambda$execute$0(ExecutorUtil.java:188)
at
java.base/java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1167)
at
java.base/java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:641)
... 1 more
Build Log:
[...truncated 13499 lines...]
[junit4] Suite: org.apache.solr.cloud.ChaosMonkeyNothingIsSafeTest
[junit4] 2> 1033515 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[506547354F7EF2A5]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\init-core-data-001
[junit4] 2> 1033516 WARN
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[506547354F7EF2A5]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=27 numCloses=27
[junit4] 2> 1033516 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[506547354F7EF2A5]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 1033517 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[506547354F7EF2A5]-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> 1033517 INFO
(SUITE-ChaosMonkeyNothingIsSafeTest-seed#[506547354F7EF2A5]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 1033520 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 1033521 INFO (Thread-1747) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 1033521 INFO (Thread-1747) [ ] o.a.s.c.ZkTestServer
Starting server
[junit4] 2> 1033526 ERROR (Thread-1747) [ ] o.a.z.s.ZooKeeperServer
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action
on ERROR or SHUTDOWN server state changes
[junit4] 2> 1033621 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkTestServer start zk server on port:56816
[junit4] 2> 1033634 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e478d52fb0000, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1033648 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 1033651 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\schema15.xml
to /configs/conf1/schema.xml
[junit4] 2> 1033656 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 1033665 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 1033671 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 1033671 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 1033685 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 1033688 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 1033702 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 1033704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 1033710 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractZkTestCase put
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\core\src\test-files\solr\collection1\conf\synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 1033715 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e478d52fb0001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1033715 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use TLOG replicas unless explicitly
asked otherwise
[junit4] 2> 1034374 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1034375 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@750815c5{/,null,AVAILABLE}
[junit4] 2> 1034377 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@64bc98e4{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1034377 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1034377 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/control/data,
hostPort=56827,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\control-001\cores}
[junit4] 2> 1034378 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1034378 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1034378 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1034378 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1034378 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:18.608381100Z
[junit4] 2> 1034382 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1034382 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\control-001\solr.xml
[junit4] 2> 1034385 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1034388 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1034530 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1034531 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:56827_
[junit4] 2> 1034532 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=98594914156871684-127.0.0.1:56827_-n_0000000000)
starting
[junit4] 2> 1034540 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56827_
[junit4] 2> 1034542 INFO
(OverseerStateUpdate-98594914156871684-127.0.0.1:56827_-n_0000000000) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1034595 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1034613 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1034613 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1034615 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\control-001\cores
[junit4] 2> 1034636 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1034637 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56816/solr ready
[junit4] 2> 1034641 INFO (qtp156565332-10723) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:56827_&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1034644 INFO (OverseerThreadFactory-3698-thread-1) [ ]
o.a.s.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 1034755 INFO (qtp156565332-10725) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 1034756 INFO (qtp156565332-10725) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1034865 INFO (zkCallback-2720-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1035776 INFO (qtp156565332-10725) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1035786 INFO (qtp156565332-10725) [ ] o.a.s.s.IndexSchema
[control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 1035868 INFO (qtp156565332-10725) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1035904 INFO (qtp156565332-10725) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from collection control_collection, trusted=true
[junit4] 2> 1035904 INFO (qtp156565332-10725) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.control_collection.shard1.replica_n1' (registry
'solr.core.control_collection.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1035904 INFO (qtp156565332-10725) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1035906 INFO (qtp156565332-10725) [ ] o.a.s.c.SolrCore
[[control_collection_shard1_replica_n1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\control-001\cores\control_collection_shard1_replica_n1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\control-001\cores\control_collection_shard1_replica_n1\data\]
[junit4] 2> 1035916 INFO (qtp156565332-10725) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=953926027,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1035921 WARN (qtp156565332-10725) [ ]
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> 1036000 INFO (qtp156565332-10725) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1036000 INFO (qtp156565332-10725) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1036002 INFO (qtp156565332-10725) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1036002 INFO (qtp156565332-10725) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1036004 INFO (qtp156565332-10725) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6019098754638804]
[junit4] 2> 1036005 INFO (qtp156565332-10725) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@c2853f8[control_collection_shard1_replica_n1] main]
[junit4] 2> 1036007 INFO (qtp156565332-10725) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1036008 INFO (qtp156565332-10725) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1036008 INFO (qtp156565332-10725) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1036008 INFO (qtp156565332-10725) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1577518629113561088
[junit4] 2> 1036008 INFO (searcherExecutor-3701-thread-1) [ ]
o.a.s.c.SolrCore [control_collection_shard1_replica_n1] Registered new searcher
Searcher@c2853f8[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:56827/control_collection_shard1_replica_n1/
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ] o.a.s.c.SyncStrategy
http://127.0.0.1:56827/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 1036025 INFO (qtp156565332-10725) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1036032 INFO (qtp156565332-10725) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:56827/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 1036136 INFO (zkCallback-2720-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1036185 INFO (qtp156565332-10725) [ ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 1036186 INFO (qtp156565332-10725) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&newCollection=true&name=control_collection_shard1_replica_n1&action=CREATE&numShards=1&collection=control_collection&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1431
[junit4] 2> 1036191 INFO (qtp156565332-10723) [ ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1036293 INFO (zkCallback-2720-thread-1) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/control_collection/state.json] for collection
[control_collection] has occurred - updating... (live nodes size: [1])
[junit4] 2> 1036649 INFO
(OverseerCollectionConfigSetProcessor-98594914156871684-127.0.0.1:56827_-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1037192 INFO (qtp156565332-10723) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:56827_&wt=javabin&version=2}
status=0 QTime=2550
[junit4] 2> 1037200 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1037202 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:56816/solr ready
[junit4] 2> 1037202 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 1037203 INFO (qtp156565332-10728) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1037207 INFO (OverseerThreadFactory-3698-thread-2) [ ]
o.a.s.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 1037208 WARN (OverseerThreadFactory-3698-thread-2) [ ]
o.a.s.c.CreateCollectionCmd It is unusual to create a collection (collection1)
without cores.
[junit4] 2> 1037411 INFO (qtp156565332-10728) [ ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 1037411 INFO (qtp156565332-10728) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=3&createNodeSet=&stateFormat=1&wt=javabin&version=2}
status=0 QTime=207
[junit4] 2> 1037701 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001
of type TLOG
[junit4] 2> 1037702 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1037702 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@31bd1351{/,null,AVAILABLE}
[junit4] 2> 1037703 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@43ebd2e6{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solrconfig=solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/jetty1,
hostPort=56861,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001\cores,
replicaType=TLOG}
[junit4] 2> 1037704 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1037704 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:21.934555900Z
[junit4] 2> 1037710 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1037710 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001\solr.xml
[junit4] 2> 1037714 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1037717 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1037720 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e478d52fb0008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1037730 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 1037732 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1037735 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56861_
[junit4] 2> 1037737 INFO (zkCallback-2732-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1037737 INFO (zkCallback-2727-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1037737 INFO (zkCallback-2720-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 1037784 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1037809 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1037810 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1037811 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001\cores
[junit4] 2> 1037842 INFO (qtp156565332-10721) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params
node=127.0.0.1:56861_&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1037845 INFO
(OverseerCollectionConfigSetProcessor-98594914156871684-127.0.0.1:56827_-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000002 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1037845 INFO (OverseerThreadFactory-3698-thread-3) [ ]
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:56861_ for creating new replica
[junit4] 2> 1037848 INFO (qtp1875145951-10764) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t61&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1037849 INFO (qtp1875145951-10764) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1038864 INFO (qtp1875145951-10764) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1038881 INFO (qtp1875145951-10764) [ ] o.a.s.s.IndexSchema
[collection1_shard2_replica_t61] Schema name=test
[junit4] 2> 1038949 INFO (qtp1875145951-10764) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1038964 INFO (qtp1875145951-10764) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_t61' using
configuration from collection collection1, trusted=true
[junit4] 2> 1038965 INFO (qtp1875145951-10764) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_t61' (registry
'solr.core.collection1.shard2.replica_t61') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1038965 INFO (qtp1875145951-10764) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1038965 INFO (qtp1875145951-10764) [ ] o.a.s.c.SolrCore
[[collection1_shard2_replica_t61] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001\cores\collection1_shard2_replica_t61],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-1-001\cores\collection1_shard2_replica_t61\data\]
[junit4] 2> 1038970 INFO (qtp1875145951-10764) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=953926027,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1038974 WARN (qtp1875145951-10764) [ ]
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> 1039018 INFO (qtp1875145951-10764) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1039018 INFO (qtp1875145951-10764) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1039019 INFO (qtp1875145951-10764) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1039019 INFO (qtp1875145951-10764) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1039020 INFO (qtp1875145951-10764) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6019098754638804]
[junit4] 2> 1039021 INFO (qtp1875145951-10764) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@4e396814[collection1_shard2_replica_t61] main]
[junit4] 2> 1039022 INFO (qtp1875145951-10764) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1039022 INFO (qtp1875145951-10764) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1039023 INFO (qtp1875145951-10764) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1039023 INFO (qtp1875145951-10764) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1577518632275017728
[junit4] 2> 1039024 INFO (searcherExecutor-3712-thread-1) [ ]
o.a.s.c.SolrCore [collection1_shard2_replica_t61] Registered new searcher
Searcher@4e396814[collection1_shard2_replica_t61]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56861/collection1_shard2_replica_t61/
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:56861/collection1_shard2_replica_t61/ has
no replicas
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1039030 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ZkController collection1_shard2_replica_t61 stopping background
replication from leader
[junit4] 2> 1039033 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:56861/collection1_shard2_replica_t61/ shard2
[junit4] 2> 1039185 INFO (qtp1875145951-10764) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1039187 INFO (qtp1875145951-10764) [ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t61&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=1339
[junit4] 2> 1039191 INFO (qtp156565332-10721) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={node=127.0.0.1:56861_&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2}
status=0 QTime=1350
[junit4] 2> 1039510 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001
of type TLOG
[junit4] 2> 1039510 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1039511 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@4fcf12d8{/,null,AVAILABLE}
[junit4] 2> 1039511 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@59ae0bd5{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solrconfig=solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/jetty2,
hostPort=56874,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001\cores,
replicaType=TLOG}
[junit4] 2> 1039513 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1039513 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:23.743348900Z
[junit4] 2> 1039516 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1039516 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001\solr.xml
[junit4] 2> 1039519 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1039521 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1039531 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 1039533 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1039534 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56874_
[junit4] 2> 1039536 INFO (zkCallback-2727-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1039536 INFO (zkCallback-2738-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1039536 INFO (zkCallback-2720-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1039536 INFO (zkCallback-2732-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 1039586 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1039594 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1039594 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1039595 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001\cores
[junit4] 2> 1039620 INFO (qtp156565332-10724) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params
node=127.0.0.1:56874_&action=ADDREPLICA&collection=collection1&shard=shard3&type=TLOG&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1039623 INFO
(OverseerCollectionConfigSetProcessor-98594914156871684-127.0.0.1:56827_-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000004 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1039623 INFO (OverseerThreadFactory-3698-thread-4) [ ]
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:56874_ for creating new replica
[junit4] 2> 1039627 INFO (qtp1491512389-10794) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard3_replica_t63&action=CREATE&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1039627 INFO (qtp1491512389-10794) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1040642 INFO (qtp1491512389-10794) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1040651 INFO (qtp1491512389-10794) [ ] o.a.s.s.IndexSchema
[collection1_shard3_replica_t63] Schema name=test
[junit4] 2> 1040736 INFO (qtp1491512389-10794) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1040762 INFO (qtp1491512389-10794) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard3_replica_t63' using
configuration from collection collection1, trusted=true
[junit4] 2> 1040762 INFO (qtp1491512389-10794) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard3.replica_t63' (registry
'solr.core.collection1.shard3.replica_t63') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1040763 INFO (qtp1491512389-10794) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1040763 INFO (qtp1491512389-10794) [ ] o.a.s.c.SolrCore
[[collection1_shard3_replica_t63] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001\cores\collection1_shard3_replica_t63],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-2-001\cores\collection1_shard3_replica_t63\data\]
[junit4] 2> 1040771 INFO (qtp1491512389-10794) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=953926027,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1040777 WARN (qtp1491512389-10794) [ ]
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> 1040848 INFO (qtp1491512389-10794) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1040848 INFO (qtp1491512389-10794) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1040850 INFO (qtp1491512389-10794) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1040850 INFO (qtp1491512389-10794) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1040851 INFO (qtp1491512389-10794) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6019098754638804]
[junit4] 2> 1040852 INFO (qtp1491512389-10794) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@71462f8[collection1_shard3_replica_t63] main]
[junit4] 2> 1040855 INFO (qtp1491512389-10794) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1040855 INFO (qtp1491512389-10794) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1040856 INFO (qtp1491512389-10794) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1040856 INFO (qtp1491512389-10794) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1577518634197057536
[junit4] 2> 1040858 INFO (searcherExecutor-3723-thread-1) [ ]
o.a.s.c.SolrCore [collection1_shard3_replica_t63] Registered new searcher
Searcher@71462f8[collection1_shard3_replica_t63]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56874/collection1_shard3_replica_t63/
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:56874/collection1_shard3_replica_t63/ has
no replicas
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1040869 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ZkController collection1_shard3_replica_t63 stopping background
replication from leader
[junit4] 2> 1040874 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:56874/collection1_shard3_replica_t63/ shard3
[junit4] 2> 1041027 INFO (qtp1491512389-10794) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1041029 INFO (qtp1491512389-10794) [ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard3_replica_t63&action=CREATE&collection=collection1&shard=shard3&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=1401
[junit4] 2> 1041032 INFO (qtp156565332-10724) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={node=127.0.0.1:56874_&action=ADDREPLICA&collection=collection1&shard=shard3&type=TLOG&wt=javabin&version=2}
status=0 QTime=1411
[junit4] 2> 1041389 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001
of type TLOG
[junit4] 2> 1041389 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1041390 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6f993b44{/,null,AVAILABLE}
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@6384417f{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solrconfig=solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/jetty3,
hostPort=56893,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001\cores,
replicaType=TLOG}
[junit4] 2> 1041391 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1041391 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1041392 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:25.622621500Z
[junit4] 2> 1041394 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1041394 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001\solr.xml
[junit4] 2> 1041397 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1041399 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1041409 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 1041411 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1041413 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56893_
[junit4] 2> 1041415 INFO (zkCallback-2744-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1041415 INFO (zkCallback-2738-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1041415 INFO (zkCallback-2727-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1041415 INFO (zkCallback-2732-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1041415 INFO (zkCallback-2720-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 1041473 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1041481 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1041481 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1041482 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001\cores
[junit4] 2> 1041523 INFO (qtp156565332-10725) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params
node=127.0.0.1:56893_&action=ADDREPLICA&collection=collection1&shard=shard1&type=TLOG&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1041526 INFO (OverseerThreadFactory-3698-thread-5) [ ]
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:56893_ for creating new replica
[junit4] 2> 1041528 INFO
(OverseerCollectionConfigSetProcessor-98594914156871684-127.0.0.1:56827_-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000006 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1041532 INFO (qtp1367006603-10823) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_t65&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1041532 INFO (qtp1367006603-10823) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1042553 INFO (qtp1367006603-10823) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1042564 INFO (qtp1367006603-10823) [ ] o.a.s.s.IndexSchema
[collection1_shard1_replica_t65] Schema name=test
[junit4] 2> 1042653 INFO (qtp1367006603-10823) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1042680 INFO (qtp1367006603-10823) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_t65' using
configuration from collection collection1, trusted=true
[junit4] 2> 1042681 INFO (qtp1367006603-10823) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_t65' (registry
'solr.core.collection1.shard1.replica_t65') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1042681 INFO (qtp1367006603-10823) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1042681 INFO (qtp1367006603-10823) [ ] o.a.s.c.SolrCore
[[collection1_shard1_replica_t65] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001\cores\collection1_shard1_replica_t65],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-3-001\cores\collection1_shard1_replica_t65\data\]
[junit4] 2> 1042692 INFO (qtp1367006603-10823) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=953926027,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1042699 WARN (qtp1367006603-10823) [ ]
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> 1042760 INFO (qtp1367006603-10823) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1042760 INFO (qtp1367006603-10823) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1042762 INFO (qtp1367006603-10823) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1042762 INFO (qtp1367006603-10823) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1042764 INFO (qtp1367006603-10823) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6019098754638804]
[junit4] 2> 1042765 INFO (qtp1367006603-10823) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@3172d1ec[collection1_shard1_replica_t65] main]
[junit4] 2> 1042767 INFO (qtp1367006603-10823) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1042767 INFO (qtp1367006603-10823) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1042768 INFO (qtp1367006603-10823) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1042769 INFO (searcherExecutor-3734-thread-1) [ ]
o.a.s.c.SolrCore [collection1_shard1_replica_t65] Registered new searcher
Searcher@3172d1ec[collection1_shard1_replica_t65]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1042771 INFO (qtp1367006603-10823) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1577518636205080576
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:56893/collection1_shard1_replica_t65/
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.SyncStrategy http://127.0.0.1:56893/collection1_shard1_replica_t65/ has
no replicas
[junit4] 2> 1042786 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in
election, clear LIR
[junit4] 2> 1042787 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ZkController collection1_shard1_replica_t65 stopping background
replication from leader
[junit4] 2> 1042788 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:56893/collection1_shard1_replica_t65/ shard1
[junit4] 2> 1042945 INFO (qtp1367006603-10823) [ ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 1042947 INFO (qtp1367006603-10823) [ ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_t65&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=1414
[junit4] 2> 1042949 INFO (qtp156565332-10725) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={node=127.0.0.1:56893_&action=ADDREPLICA&collection=collection1&shard=shard1&type=TLOG&wt=javabin&version=2}
status=0 QTime=1426
[junit4] 2> 1043227 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001
of type TLOG
[junit4] 2> 1043228 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1043228 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@721022ef{/,null,AVAILABLE}
[junit4] 2> 1043229 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@5518d5cc{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1043229 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1043229 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solrconfig=solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/jetty4,
hostPort=56917,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001\cores,
replicaType=TLOG}
[junit4] 2> 1043229 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1043230 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1043230 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1043230 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1043230 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:27.460180400Z
[junit4] 2> 1043233 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1043233 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001\solr.xml
[junit4] 2> 1043235 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1043237 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1043240 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e478d52fb0011, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 1043247 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 1043248 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1043250 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56917_
[junit4] 2> 1043251 INFO (zkCallback-2744-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043251 INFO (zkCallback-2738-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043252 INFO (zkCallback-2727-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043252 INFO (zkCallback-2732-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043252 INFO (zkCallback-2720-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043252 INFO (zkCallback-2750-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 1043318 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1043327 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm')
enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1043327 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1043330 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001\cores
[junit4] 2> 1043382 INFO (qtp156565332-10723) [ ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params
node=127.0.0.1:56917_&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 1043384 INFO (OverseerThreadFactory-3698-thread-5) [ ]
o.a.s.c.AddReplicaCmd Node Identified 127.0.0.1:56917_ for creating new replica
[junit4] 2> 1043385 INFO
(OverseerCollectionConfigSetProcessor-98594914156871684-127.0.0.1:56827_-n_0000000000)
[ ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000008 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 1043389 INFO (qtp932665653-10852) [ ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t67&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG
[junit4] 2> 1043390 INFO (qtp932665653-10852) [ ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4
transient cores
[junit4] 2> 1044405 INFO (qtp932665653-10852) [ ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 8.0.0
[junit4] 2> 1044412 INFO (qtp932665653-10852) [ ] o.a.s.s.IndexSchema
[collection1_shard2_replica_t67] Schema name=test
[junit4] 2> 1044484 INFO (qtp932665653-10852) [ ] o.a.s.s.IndexSchema
Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 1044503 INFO (qtp932665653-10852) [ ]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_t67' using
configuration from collection collection1, trusted=true
[junit4] 2> 1044504 INFO (qtp932665653-10852) [ ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_t67' (registry
'solr.core.collection1.shard2.replica_t67') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b
[junit4] 2> 1044504 INFO (qtp932665653-10852) [ ] o.a.s.c.SolrCore
solr.RecoveryStrategy.Builder
[junit4] 2> 1044504 INFO (qtp932665653-10852) [ ] o.a.s.c.SolrCore
[[collection1_shard2_replica_t67] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001\cores\collection1_shard2_replica_t67],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-4-001\cores\collection1_shard2_replica_t67\data\]
[junit4] 2> 1044514 INFO (qtp932665653-10852) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy:
minMergeSize=0, mergeFactor=10, maxMergeSize=953926027,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.1]
[junit4] 2> 1044518 WARN (qtp932665653-10852) [ ]
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> 1044583 INFO (qtp932665653-10852) [ ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 1044583 INFO (qtp932665653-10852) [ ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 1044585 INFO (qtp932665653-10852) [ ]
o.a.s.u.CommitTracker Hard AutoCommit: if uncommited for 15000ms;
[junit4] 2> 1044585 INFO (qtp932665653-10852) [ ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 1044586 INFO (qtp932665653-10852) [ ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy:
minMergeSize=1000, mergeFactor=20, maxMergeSize=9223372036854775807,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.6019098754638804]
[junit4] 2> 1044587 INFO (qtp932665653-10852) [ ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@74d9a48[collection1_shard2_replica_t67] main]
[junit4] 2> 1044588 INFO (qtp932665653-10852) [ ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 1044589 INFO (qtp932665653-10852) [ ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 1044590 INFO (qtp932665653-10852) [ ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 1044590 INFO (searcherExecutor-3745-thread-1) [ ]
o.a.s.c.SolrCore [collection1_shard2_replica_t67] Registered new searcher
Searcher@74d9a48[collection1_shard2_replica_t67]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 1044591 INFO (qtp932665653-10852) [ ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1577518638113488896
[junit4] 2> 1044594 INFO (qtp932665653-10852) [ ] o.a.s.c.ZkController
Core needs to recover:collection1_shard2_replica_t67
[junit4] 2> 1044595 INFO (updateExecutor-2747-thread-1) [ ]
o.a.s.u.DefaultSolrCoreState Running recovery
[junit4] 2> 1044595 INFO (qtp932665653-10852) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_t67&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=TLOG}
status=0 QTime=1205
[junit4] 2> 1044595 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.RecoveryStrategy Starting recovery process. recoveringAfterStartup=true
[junit4] 2> 1044596 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.RecoveryStrategy ###### startupVersions=[[]]
[junit4] 2> 1044596 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.ZkController collection1_shard2_replica_t67 stopping background
replication from leader
[junit4] 2> 1044596 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.RecoveryStrategy Begin buffering updates.
core=[collection1_shard2_replica_t67]
[junit4] 2> 1044596 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.u.UpdateLog Starting to buffer updates. FSUpdateLog{state=ACTIVE,
tlog=null}
[junit4] 2> 1044596 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.RecoveryStrategy Publishing state of core
[collection1_shard2_replica_t67] as recovering, leader is
[http://127.0.0.1:56861/collection1_shard2_replica_t61/] and I am
[http://127.0.0.1:56917/collection1_shard2_replica_t67/]
[junit4] 2> 1044598 INFO (qtp156565332-10723) [ ] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/collections
params={node=127.0.0.1:56917_&action=ADDREPLICA&collection=collection1&shard=shard2&type=TLOG&wt=javabin&version=2}
status=0 QTime=1215
[junit4] 2> 1044598 INFO (recoveryExecutor-2748-thread-1) [ ]
o.a.s.c.RecoveryStrategy Sending prep recovery command to
[http://127.0.0.1:56861]; [WaitForState:
action=PREPRECOVERY&core=collection1_shard2_replica_t61&nodeName=127.0.0.1:56917_&coreNodeName=core_node68&state=recovering&checkLive=true&onlyIfLeader=true&onlyIfLeaderActive=true]
[junit4] 2> 1044601 INFO (qtp1875145951-10766) [ ]
o.a.s.h.a.PrepRecoveryOp Going to wait for coreNodeName: core_node68, state:
recovering, checkLive: true, onlyIfLeader: true, onlyIfLeaderActive: true,
maxTime: 183 s
[junit4] 2> 1044602 INFO (qtp1875145951-10766) [ ]
o.a.s.h.a.PrepRecoveryOp In WaitForState(recovering): collection=collection1,
shard=shard2, thisCore=collection1_shard2_replica_t61,
leaderDoesNotNeedRecovery=false, isLeader? true, live=true, checkLive=true,
currentState=down, localState=active, nodeName=127.0.0.1:56917_,
coreNodeName=core_node68, onlyIfActiveCheckResult=false, nodeProps:
core_node68:{"core":"collection1_shard2_replica_t67","base_url":"http://127.0.0.1:56917","node_name":"127.0.0.1:56917_","state":"down","type":"TLOG"}
[junit4] 2> 1044965 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 5 in directory
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-5-001
of type TLOG
[junit4] 2> 1044966 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server jetty-9.3.20.v20170531
[junit4] 2> 1044967 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@278df595{/,null,AVAILABLE}
[junit4] 2> 1044967 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.AbstractConnector Started
ServerConnector@c4d958c{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.e.j.s.Server Started @???????ms
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/,
solrconfig=solrconfig.xml,
solr.data.dir=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\tempDir-001/jetty5,
hostPort=56934,
coreRootDirectory=C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\..\..\..\..\..\..\..\..\..\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-5-001\cores,
replicaType=TLOG}
[junit4] 2> 1044968 ERROR
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.0.0
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null, Default config
dir: null
[junit4] 2> 1044968 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2017-09-03T11:43:29.198694800Z
[junit4] 2> 1044973 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 1044973 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.ChaosMonkeyNothingIsSafeTest_506547354F7EF2A5-001\shard-5-001\solr.xml
[junit4] 2> 1044988 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@2bd63a8b, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 1044991 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:56816/solr
[junit4] 2> 1045003 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 1045005 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.Overseer Overseer (id=null) closing
[junit4] 2> 1045006 INFO
(TEST-ChaosMonkeyNothingIsSafeTest.test-seed#[506547354F7EF2A5]) [ ]
o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:56934_
[junit4] 2> 1045010 INFO (zkCallback-2757-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-2744-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-2738-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-2727-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-2720-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-2732-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (5) -> (6)
[junit4] 2> 1045010 INFO (zkCallback-275
[...truncated too long message...]
thread-1) [ ] o.a.s.c.SolrCore [mainCorpus_shard1_replica_n1] CLOSING
SolrCore org.apache.solr.core.SolrCore@1cc4632e
[junit4] 2> 138224 INFO (coreCloseExecutor-220-thread-2) [ ]
o.a.s.c.SolrCore [destination_shard2_replica_n2] CLOSING SolrCore
org.apache.solr.core.SolrCore@6ffd6fa5
[junit4] 2> 138226 INFO (coreCloseExecutor-220-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.destination.shard2.replica_n2, tag=1878880165
[junit4] 2> 138226 INFO (coreCloseExecutor-220-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@48e12dfc: rootName =
solr_54280, domain = solr.core.destination.shard2.replica_n2, service url =
null, agent id = null] for registry solr.core.destination.shard2.replica_n2 /
com.codahale.metrics.MetricRegistry@3a105857
[junit4] 2> 138227 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x15e47fc40c00064, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
[junit4] 2> at java.base/java.lang.Thread.run(Thread.java:844)
[junit4] 2> 138248 INFO (coreCloseExecutor-218-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.collection1.shard1.leader, tag=680483305
[junit4] 2> 138248 INFO (coreCloseExecutor-218-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.destination.shard1.replica_n1, tag=1143775883
[junit4] 2> 138249 INFO (coreCloseExecutor-218-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7847c5d0: rootName =
solr_54282, domain = solr.core.destination.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.destination.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@31182ed8
[junit4] 2> 138267 INFO (coreCloseExecutor-217-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.collection1.shard2.leader, tag=314130528
[junit4] 2> 138270 INFO (coreCloseExecutor-219-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.workQueue.shard2.leader, tag=626828340
[junit4] 2> 138270 INFO (coreCloseExecutor-220-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.destination.shard2.leader, tag=1878880165
[junit4] 2> 138270 INFO (coreCloseExecutor-219-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.mainCorpus.shard2.replica_n3, tag=1030471154
[junit4] 2> 138271 INFO (coreCloseExecutor-219-thread-2) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@7682bb3f: rootName =
solr_54279, domain = solr.core.mainCorpus.shard2.replica_n3, service url =
null, agent id = null] for registry solr.core.mainCorpus.shard2.replica_n3 /
com.codahale.metrics.MetricRegistry@7971c98
[junit4] 2> 138272 INFO (coreCloseExecutor-218-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.destination.shard1.leader, tag=1143775883
[junit4] 2> 138270 INFO (coreCloseExecutor-220-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.core.mainCorpus.shard1.replica_n1, tag=482632494
[junit4] 2> 138272 INFO (coreCloseExecutor-220-thread-1) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2af317f1: rootName =
solr_54280, domain = solr.core.mainCorpus.shard1.replica_n1, service url =
null, agent id = null] for registry solr.core.mainCorpus.shard1.replica_n1 /
com.codahale.metrics.MetricRegistry@32080d12
[junit4] 2> 138276 INFO (jetty-closer-2-thread-3) [ ] o.a.s.c.Overseer
Overseer (id=98595390592385033-127.0.0.1:54281_solr-n_0000000000) closing
[junit4] 2> 138277 INFO
(OverseerStateUpdate-98595390592385033-127.0.0.1:54281_solr-n_0000000000) [
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:54281_solr
[junit4] 2> 138283 WARN (zkCallback-20-thread-2) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 138286 INFO (jetty-closer-2-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5ef4d7f0{/solr,null,UNAVAILABLE}
[junit4] 2> 138287 INFO (zkCallback-23-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 138287 INFO (zkCallback-21-thread-1) [ ]
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:54280_solr
[junit4] 2> 138288 INFO (zkCallback-21-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
[junit4] 2> 138287 INFO (zkCallback-22-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (3)
[junit4] 2> 138288 WARN (zkCallback-23-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 138287 INFO (coreCloseExecutor-219-thread-2) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.mainCorpus.shard2.leader, tag=1030471154
[junit4] 2> 138290 INFO (jetty-closer-2-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@463ea49e{/solr,null,UNAVAILABLE}
[junit4] 2> 138291 INFO (zkCallback-22-thread-2) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (2)
[junit4] 2> 138296 INFO (coreCloseExecutor-220-thread-1) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.collection.mainCorpus.shard1.leader, tag=482632494
[junit4] 2> 138296 INFO (coreCloseExecutor-220-thread-1) [ ]
o.a.s.u.DirectUpdateHandler2 Committing on IndexWriter close.
[junit4] 2> 138296 INFO (coreCloseExecutor-220-thread-1) [ ]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@38f06662 commitCommandVersion:0
[junit4] 2> 138297 INFO (jetty-closer-2-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@5128734e{/solr,null,UNAVAILABLE}
[junit4] 2> 138299 INFO (zkCallback-21-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 138305 WARN (zkCallback-21-thread-1) [ ]
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK:
[KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 138306 INFO (jetty-closer-2-thread-2) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3f55b1a7{/solr,null,UNAVAILABLE}
[junit4] 2> 138308 ERROR
(SUITE-StreamExpressionTest-seed#[48DD08D112D3AD0F]-worker) [ ]
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper
server won't take any action on ERROR or SHUTDOWN server state changes
[junit4] 2> 138309 INFO
(SUITE-StreamExpressionTest-seed#[48DD08D112D3AD0F]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:54272 54272
[junit4] 2> 138312 INFO (Thread-0) [ ] o.a.s.c.ZkTestServer connecting
to 127.0.0.1:54272 54272
[junit4] 2> 138314 WARN (Thread-0) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 93 /solr/aliases.json
[junit4] 2> 93 /solr/clusterprops.json
[junit4] 2> 12 /solr/configs/conf
[junit4] 2> 8 /solr/configs/ml
[junit4] 2> 4 /solr/security.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 93 /solr/clusterstate.json
[junit4] 2> 38
/solr/collections/destinationCollection/state.json
[junit4] 2> 28
/solr/collections/parallelDestinationCollection1/state.json
[junit4] 2> 20 /solr/collections/destination/state.json
[junit4] 2> 20
/solr/collections/parallelDestinationCollection/state.json
[junit4] 2> 20 /solr/collections/mainCorpus/state.json
[junit4] 2> 18 /solr/collections/workQueue/state.json
[junit4] 2> 12 /solr/collections/collection1/state.json
[junit4] 2> 10 /solr/collections/uknownCollection/state.json
[junit4] 2> 10 /solr/collections/modelCollection/state.json
[junit4] 2> 10
/solr/collections/checkpointCollection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 93 /solr/live_nodes
[junit4] 2> 93 /solr/collections
[junit4] 2>
[junit4] 2> NOTE: leaving temporary files on disk at:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J0\temp\solr.client.solrj.io.stream.StreamExpressionTest_48DD08D112D3AD0F-001
[junit4] 2> Sep 03, 2017 1:46:45 PM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 6 leaked
thread(s).
[junit4] 2> NOTE: test params are: codec=Lucene70,
sim=RandomSimilarity(queryNorm=true): {}, locale=es,
timezone=America/Argentina/Rio_Gallegos
[junit4] 2> NOTE: Windows 10 10.0 amd64/Oracle Corporation 9
(64-bit)/cpus=3,threads=1,free=80141152,total=201502720
[junit4] 2> NOTE: All tests run in this JVM: [StreamExpressionTest]
[junit4] Completed [63/145 (1!)] on J0 in 149.03s, 95 tests, 1 error <<<
FAILURES!
[...truncated 38383 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
