Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5877/
Java: 64bit/jdk-14 -XX:+UseCompressedOops -XX:+UseG1GC
2 tests failed.
FAILED: org.apache.solr.cloud.MultiThreadedOCPTest.test
Error Message:
acoll: 1586668340010 bcoll: 1586668340188
Stack Trace:
java.lang.AssertionError: acoll: 1586668340010 bcoll: 1586668340188
at
__randomizedtesting.SeedInfo.seed([4A3EC542C6C014BF:C26AFA98683C7947]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.cloud.MultiThreadedOCPTest.testFillWorkQueue(MultiThreadedOCPTest.java:113)
at
org.apache.solr.cloud.MultiThreadedOCPTest.test(MultiThreadedOCPTest.java:68)
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:1754)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:942)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:978)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:992)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
at
org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
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:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:819)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:470)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:951)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:836)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:887)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:898)
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:370)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.lambda$forkTimeoutingTask$0(ThreadLeakControl.java:826)
at java.base/java.lang.Thread.run(Thread.java:832)
FAILED:
junit.framework.TestSuite.org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest: 1)
Thread[id=22204, name=SessionTracker, state=TIMED_WAITING,
group=TGRP-IndexSizeTriggerMixedBoundsTest] at
java.base@14/java.lang.Thread.sleep(Native Method) at
app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest:
1) Thread[id=22204, name=SessionTracker, state=TIMED_WAITING,
group=TGRP-IndexSizeTriggerMixedBoundsTest]
at java.base@14/java.lang.Thread.sleep(Native Method)
at
app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
at __randomizedtesting.SeedInfo.seed([4A3EC542C6C014BF]:0)
Build Log:
[...truncated 13756 lines...]
[junit4] Suite: org.apache.solr.cloud.MultiThreadedOCPTest
[junit4] 2> 756364 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCase Setting 'solr.default.confdir' system property to
test-framework derived value of
'/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/server/solr/configsets/_default/conf'
[junit4] 2> 756365 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 Created dataDir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/data-dir-47-001
[junit4] 2> 756366 WARN
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=1 numCloses=1
[junit4] 2> 756366 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false)
w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 756367 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0,
clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
[junit4] 2> 756367 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 756367 INFO
(SUITE-MultiThreadedOCPTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /_/m
[junit4] 2> 756374 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 756377 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 756377 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 756483 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer start zk server on port:61100
[junit4] 2> 756483 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:61100
[junit4] 2> 756484 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:61100
[junit4] 2> 756484 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 61100
[junit4] 2> 756492 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 756500 INFO (zkConnectionManagerCallback-3888-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 756500 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 756510 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 756517 INFO (zkConnectionManagerCallback-3890-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 756519 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 756531 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml
to /configs/conf1/solrconfig.xml
[junit4] 2> 756541 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml
to /configs/conf1/schema.xml
[junit4] 2> 756569 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml
to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 756581 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt
to /configs/conf1/stopwords.txt
[junit4] 2> 756592 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt
to /configs/conf1/protwords.txt
[junit4] 2> 756598 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml
to /configs/conf1/currency.xml
[junit4] 2> 756625 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml
to /configs/conf1/enumsConfig.xml
[junit4] 2> 756632 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json
to /configs/conf1/open-exchange-rates.json
[junit4] 2> 756636 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt
to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 756647 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt
to /configs/conf1/old_synonyms.txt
[junit4] 2> 756654 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkTestServer put
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt
to /configs/conf1/synonyms.txt
[junit4] 2> 756662 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly
asked otherwise
[junit4] 2> 758306 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 758306 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 758306 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ] o.e.j.s.Server
jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 758326 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 758326 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 758327 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 758329 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@5d8e90bf{/_/m,null,AVAILABLE}
[junit4] 2> 758342 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@2bf3f274{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:61120}
[junit4] 2> 758352 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ] o.e.j.s.Server
Started @758410ms
[junit4] 2> 758352 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_/m,
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/tempDir-001/control/data,
hostPort=61120,
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/control-001/cores,
replicaType=NRT}
[junit4] 2> 758353 ERROR
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 758356 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 758358 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 758359 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 758359 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
[junit4] 2> 758359 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-04-12T05:11:30.918263Z
[junit4] 2> 758364 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 758368 INFO (zkConnectionManagerCallback-3892-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 758369 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 758482 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 758482 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/control-001/solr.xml
[junit4] 2> 758487 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 759033 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 759039 WARN
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@51fc2ccb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 759040 WARN
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@51fc2ccb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 759057 WARN
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@26f8922d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 759057 WARN
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@26f8922d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 759061 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61100/solr
[junit4] 2> 759067 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 759073 INFO (zkConnectionManagerCallback-3899-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 759079 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 759194 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 759206 INFO (zkConnectionManagerCallback-3901-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 759208 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 760593 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:61120__%2Fm
[junit4] 2> 760604 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.Overseer Overseer
(id=72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000) starting
[junit4] 2> 760691 INFO
(OverseerStateUpdate-72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000)
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:61120__%2Fm
[junit4] 2> 760694 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61120__%2Fm
[junit4] 2> 760706 INFO
(OverseerStateUpdate-72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000)
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 760730 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 760731 WARN
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 760780 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 760841 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 760865 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 760866 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 760868 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF])
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/control-001/cores
[junit4] 2> 760883 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 760888 INFO (zkConnectionManagerCallback-3910-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 760889 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 760904 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 760912 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61100/solr ready
[junit4] 2> 760917 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:61120__%252Fm&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 760966 INFO
(OverseerThreadFactory-3224-thread-1-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.a.c.CreateCollectionCmd Create
collection control_collection
[junit4] 2> 761121 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
x:control_collection_shard1_replica_n1 ] 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> 761121 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault
Allocating transient cache for 4 transient cores
[junit4] 2> 762206 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 9.0.0
[junit4] 2> 762232 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.s.IndexSchema Schema name=test
[junit4] 2> 762600 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 763142 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.CoreContainer Creating SolrCore 'control_collection_shard1_replica_n1'
using configuration from configset conf1, trusted=true
[junit4] 2> 763143 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
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@5a4718c2
[junit4] 2> 763144 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.SolrCore [[control_collection_shard1_replica_n1] ] Opening new SolrCore
at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/control-001/cores/control_collection_shard1_replica_n1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 763149 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 763162 WARN (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
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> 763476 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 763476 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 763711 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 763711 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 763728 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=43, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=105.2890625,
floorSegmentMB=1.583984375, forceMergeDeletesPctAllowed=0.42404657548829605,
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.619545685945069, deletesPctAllowed=20.54366789522263
[junit4] 2> 763748 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@985a08f[control_collection_shard1_replica_n1] main]
[junit4] 2> 763806 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 763810 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 763811 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 763811 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1663742295534469120
[junit4] 2> 763831 INFO
(searcherExecutor-3229-thread-1-processing-n:127.0.0.1:61120__%2Fm
x:control_collection_shard1_replica_n1 c:control_collection s:shard1)
[n:127.0.0.1:61120__%2Fm c:control_collection s:shard1
x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrCore
[control_collection_shard1_replica_n1] Registered new searcher
Searcher@985a08f[control_collection_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 763875 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/control_collection/terms/shard1 to Terms{values={core_node2=0},
version=0}
[junit4] 2> 763875 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/control_collection/leaders/shard1
[junit4] 2> 763900 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 763900 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 763900 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Sync replicas to
http://127.0.0.1:61120/_/m/control_collection_shard1_replica_n1/
[junit4] 2> 763902 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 763903 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.SyncStrategy
http://127.0.0.1:61120/_/m/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 763903 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/control_collection/leaders/shard1/leader after winning as
/collections/control_collection/leader_elect/shard1/election/72146532169154564-core_node2-n_0000000000
[junit4] 2> 763924 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:61120/_/m/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 763929 INFO (zkCallback-3900-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> 763930 INFO (zkCallback-3900-thread-2) [ ]
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> 763938 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 763952 INFO (qtp1497717821-10893) [n:127.0.0.1:61120__%2Fm
] 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=2831
[junit4] 2> 763968 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 45 seconds. Check all shard replicas
[junit4] 2> 764054 INFO (zkCallback-3900-thread-2) [ ]
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> 764054 INFO (zkCallback-3900-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> 764055 INFO (zkCallback-3900-thread-3) [ ]
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> 764057 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=control_collection&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=127.0.0.1:61120__%252Fm&wt=javabin&version=2}
status=0 QTime=3140
[junit4] 2> 764058 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in
collection: control_collection
[junit4] 2> 764172 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 764178 INFO (zkConnectionManagerCallback-3916-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 764178 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 764182 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 764186 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61100/solr ready
[junit4] 2> 764186 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection
loss:false
[junit4] 2> 764189 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 764204 INFO
(OverseerThreadFactory-3224-thread-2-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.a.c.CreateCollectionCmd Create
collection collection1
[junit4] 2> 764205 INFO
(OverseerCollectionConfigSetProcessor-72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000)
[n:127.0.0.1:61120__%2Fm ] 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> 764420 WARN
(OverseerThreadFactory-3224-thread-2-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to
create a collection (collection1) without cores.
[junit4] 2> 764442 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at
most 45 seconds. Check all shard replicas
[junit4] 2> 764446 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=1&wt=javabin&version=2}
status=0 QTime=257
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active slice count: 2 expected:2
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 764450 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances
pullReplicaCount=0 numOtherReplicas=3
[junit4] 2> 765175 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-1-001
of type NRT for shard2
[junit4] 2> 765178 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 765178 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 765178 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@57dc7c32{/_/m,null,AVAILABLE}
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@43b3fe16{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:61183}
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.e.j.s.Server Started @765246ms
[junit4] 2> 765180 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_/m,
solrconfig=solrconfig.xml,
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/tempDir-001/jetty1,
hostPort=61183,
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-1-001/cores}
[junit4] 2> 765185 ERROR (closeThreadPool-3917-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 765185 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 765185 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 765185 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 765185 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
[junit4] 2> 765185 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-04-12T05:11:37.744432Z
[junit4] 2> 765186 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 765191 INFO (zkConnectionManagerCallback-3919-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 765191 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 765294 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 765294 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-1-001/solr.xml
[junit4] 2> 765299 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 766239 INFO
(OverseerCollectionConfigSetProcessor-72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000)
[n:127.0.0.1:61120__%2Fm ] 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> 766503 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001
of type NRT for shard1
[junit4] 2> 766507 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 766507 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 766507 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 766511 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 766511 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 766511 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 766512 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@1f3528ce{/_/m,null,AVAILABLE}
[junit4] 2> 766513 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@7036cce4{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:61192}
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.Server Started @766580ms
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_/m,
solrconfig=solrconfig.xml,
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/tempDir-001/jetty2,
hostPort=61192,
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001/cores}
[junit4] 2> 766514 ERROR (closeThreadPool-3917-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
[junit4] 2> 766514 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-04-12T05:11:39.073597Z
[junit4] 2> 766515 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 766519 INFO (zkConnectionManagerCallback-3922-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 766519 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 766560 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 766570 WARN (closeThreadPool-3917-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@4ac3bbfc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766570 WARN (closeThreadPool-3917-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@4ac3bbfc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766584 WARN (closeThreadPool-3917-thread-1) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@3a571af1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766584 WARN (closeThreadPool-3917-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@3a571af1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766594 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61100/solr
[junit4] 2> 766608 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 766615 INFO (zkConnectionManagerCallback-3928-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 766618 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 766635 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 766635 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001/solr.xml
[junit4] 2> 766639 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 766737 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 766742 INFO (zkConnectionManagerCallback-3931-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 766742 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 766830 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 766852 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 766854 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@75bc3d5d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766854 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@75bc3d5d[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766880 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5184b942[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766880 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5184b942[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 766882 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61100/solr
[junit4] 2> 766885 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 766890 INFO (zkConnectionManagerCallback-3939-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 766892 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 766893 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.ZkController Publish
node=127.0.0.1:61183__%2Fm as DOWN
[junit4] 2> 766904 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 4 transient cores
[junit4] 2> 766904 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61183__%2Fm
[junit4] 2> 767013 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 767013 INFO (zkCallback-3915-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 767013 INFO (zkCallback-3900-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 767015 INFO (zkCallback-3930-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 767016 INFO (zkConnectionManagerCallback-3941-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 767016 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 767039 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 767040 WARN (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 767093 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 767101 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 767166 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.ZkController Publish
node=127.0.0.1:61192__%2Fm as DOWN
[junit4] 2> 767170 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767175 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 4 transient cores
[junit4] 2> 767177 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61192__%2Fm
[junit4] 2> 767185 INFO (zkCallback-3900-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 767185 INFO (zkCallback-3930-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 767193 INFO (zkCallback-3915-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 767193 INFO (zkCallback-3940-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 767220 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767220 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767223 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 767224 WARN (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 767227 INFO (closeThreadPool-3917-thread-1)
[n:127.0.0.1:61183__%2Fm ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-1-001/cores
[junit4] 2> 767240 INFO (closeThreadPool-3917-thread-1) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:61183__%2Fm
[junit4] 2> 767286 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 767352 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767379 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767379 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 767381 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61192__%2Fm ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001/cores
[junit4] 2> 767408 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:61192__%2Fm
[junit4] 2> 767682 INFO
(TEST-MultiThreadedOCPTest.test-seed#[4A3EC542C6C014BF]) [ ]
o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001
of type NRT for shard2
[junit4] 2> 767685 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 767685 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 767685 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.Server jetty-9.4.27.v20200227; built: 2020-02-27T18:37:21.340Z; git:
a304fd9f351f337e7c0e2a7c28878dd536149c6c; jvm 14+36
[junit4] 2> 767695 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 767695 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 767695 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 767696 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@6534ef84{/_/m,null,AVAILABLE}
[junit4] 2> 767700 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@51c3a0bc{HTTP/1.1, (http/1.1,
h2c)}{127.0.0.1:61207}
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.e.j.s.Server Started @767767ms
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/_/m,
solrconfig=solrconfig.xml,
solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/tempDir-001/jetty3,
hostPort=61207,
coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001/cores,
replicaType=NRT}
[junit4] 2> 767701 ERROR (closeThreadPool-3917-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
9.0.0
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir:
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr
[junit4] 2> 767701 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2020-04-12T05:11:40.260757Z
[junit4] 2> 767704 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 767709 INFO (zkConnectionManagerCallback-3949-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 767709 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 767843 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in
ZooKeeper)
[junit4] 2> 767844 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.SolrXmlConfig Loading container configuration from
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001/solr.xml
[junit4] 2> 767848 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.SolrXmlConfig MBean server found:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2, but no JMX reporters were
configured - adding default JMX reporter.
[junit4] 2> 768114 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 768119 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@5db4aae3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 768119 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@5db4aae3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 768131 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config Trusting all certificates configured for
Client@d809c2a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 768131 WARN (closeThreadPool-3917-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
Client@d809c2a[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 768132 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61100/solr
[junit4] 2> 768135 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 768139 INFO (zkConnectionManagerCallback-3956-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 768140 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 768279 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.c.ConnectionManager Waiting for client
to connect to ZooKeeper
[junit4] 2> 768295 INFO (zkConnectionManagerCallback-3958-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 768295 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.c.ConnectionManager Client is connected
to ZooKeeper
[junit4] 2> 768348 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 768447 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.ZkController Publish
node=127.0.0.1:61207__%2Fm as DOWN
[junit4] 2> 768474 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 4 transient cores
[junit4] 2> 768475 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:61207__%2Fm
[junit4] 2> 768482 INFO (zkCallback-3915-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 768482 INFO (zkCallback-3930-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 768483 INFO (zkCallback-3940-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 768483 INFO (zkCallback-3900-thread-3) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 768485 INFO (zkCallback-3957-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 768530 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.p.PackageLoader /packages.json updated to
version -1
[junit4] 2> 768530 WARN (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.CoreContainer Not all security plugins
configured! authentication=disabled authorization=disabled. Solr is only as
secure as you make it. Consider configuring authentication/authorization before
exposing Solr to users internal or external. See
https://s.apache.org/solrsecurity for more info
[junit4] 2> 768573 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 768626 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 768642 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 768643 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 768648 INFO (closeThreadPool-3917-thread-2)
[n:127.0.0.1:61207__%2Fm ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001/cores
[junit4] 2> 768679 INFO (closeThreadPool-3917-thread-2) [ ]
o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:61207__%2Fm
[junit4] 2> 768706 INFO (qtp1497717821-10892) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:61192__%252Fm&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 768708 INFO (qtp1497717821-10891) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:61183__%252Fm&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 768708 INFO (qtp1497717821-10890) [n:127.0.0.1:61120__%2Fm
] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with
params
node=127.0.0.1:61207__%252Fm&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 768773 INFO
(OverseerThreadFactory-3224-thread-3-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:61192__%2Fm for creating new replica of shard shard1
for collection collection1
[junit4] 2> 768778 INFO
(OverseerThreadFactory-3224-thread-4-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:61207__%2Fm for creating new replica of shard shard2
for collection collection1
[junit4] 2> 768796 INFO
(OverseerThreadFactory-3224-thread-3-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd
Returning CreateReplica command.
[junit4] 2> 768801 INFO
(OverseerThreadFactory-3224-thread-4-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd
Returning CreateReplica command.
[junit4] 2> 768805 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
x:collection1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 768811 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
x:collection1_shard2_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n2&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 770105 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 9.0.0
[junit4] 2> 770109 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig
Using Lucene MatchVersion: 9.0.0
[junit4] 2> 770131 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema
Schema name=test
[junit4] 2> 770140 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema
Schema name=test
[junit4] 2> 770403 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 770410 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema
Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 770645 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard1_replica_n1' using configuration from
configset conf1, trusted=true
[junit4] 2> 770645 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard1.replica_n1' (registry
'solr.core.collection1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 770646 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore
[[collection1_shard1_replica_n1] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001/cores/collection1_shard1_replica_n1],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-2-001/cores/collection1_shard1_replica_n1/data/]
[junit4] 2> 770652 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 770688 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.CoreContainer
Creating SolrCore 'collection1_shard2_replica_n2' using configuration from
configset conf1, trusted=true
[junit4] 2> 770689 WARN (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
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> 770692 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr.core.collection1.shard2.replica_n2' (registry
'solr.core.collection1.shard2.replica_n2') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@5a4718c2
[junit4] 2> 770692 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SolrCore
[[collection1_shard2_replica_n2] ] Opening new SolrCore at
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001/cores/collection1_shard2_replica_n2],
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.MultiThreadedOCPTest_4A3EC542C6C014BF-001/shard-3-001/cores/collection1_shard2_replica_n2/data/]
[junit4] 2> 770696 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy:
minMergeSize=1677721, mergeFactor=44, maxMergeSize=2147483648,
maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false,
maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=1.0]
[junit4] 2> 770748 WARN (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
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> 770846 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 770846 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 770860 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 770860 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 770873 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=43, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=105.2890625,
floorSegmentMB=1.583984375, forceMergeDeletesPctAllowed=0.42404657548829605,
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.619545685945069, deletesPctAllowed=20.54366789522263
[junit4] 2> 770873 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@20ee0c31[collection1_shard1_replica_n1] main]
[junit4] 2> 770884 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 770890 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 770896 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 770896 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1663742302963630080
[junit4] 2> 770904 INFO
(searcherExecutor-3258-thread-1-processing-n:127.0.0.1:61192__%2Fm
x:collection1_shard1_replica_n1 c:collection1 s:shard1)
[n:127.0.0.1:61192__%2Fm c:collection1 s:shard1
x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@20ee0c31[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 770908 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.u.UpdateHandler
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 770908 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 770942 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/collection1/terms/shard1 to
Terms{values={core_node3=0}, version=0}
[junit4] 2> 770947 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection1/leaders/shard1
[junit4] 2> 770981 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 770981 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 770981 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:61192/_/m/collection1_shard1_replica_n1/
[junit4] 2> 770982 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 770982 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy
http://127.0.0.1:61192/_/m/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 770982 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection1/leaders/shard1/leader after winning as
/collections/collection1/leader_elect/shard1/election/72146532169154572-core_node3-n_0000000000
[junit4] 2> 771074 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:61192/_/m/collection1_shard1_replica_n1/ shard1
[junit4] 2> 771094 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 771095 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.u.CommitTracker
Hard AutoCommit: disabled
[junit4] 2> 771095 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.u.CommitTracker
Soft AutoCommit: disabled
[junit4] 2> 771097 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class
org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy:
maxMergeAtOnce=43, maxMergeAtOnceExplicit=32, maxMergedSegmentMB=105.2890625,
floorSegmentMB=1.583984375, forceMergeDeletesPctAllowed=0.42404657548829605,
segmentsPerTier=29.0, maxCFSSegmentSizeMB=8.796093022207999E12,
noCFSRatio=0.619545685945069, deletesPctAllowed=20.54366789522263
[junit4] 2> 771101 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7ffdd15[collection1_shard2_replica_n2] main]
[junit4] 2> 771107 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf1
[junit4] 2> 771109 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 771110 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 771110 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1663742303188025344
[junit4] 2> 771114 INFO
(searcherExecutor-3259-thread-1-processing-n:127.0.0.1:61207__%2Fm
x:collection1_shard2_replica_n2 c:collection1 s:shard2)
[n:127.0.0.1:61207__%2Fm c:collection1 s:shard2
x:collection1_shard2_replica_n2 ] o.a.s.c.SolrCore
[collection1_shard2_replica_n2] Registered new searcher
Searcher@7ffdd15[collection1_shard2_replica_n2]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 771114 INFO (qtp1946764989-10962) [n:127.0.0.1:61192__%2Fm
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n1&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2309
[junit4] 2> 771119 INFO (qtp1497717821-10892) [n:127.0.0.1:61120__%2Fm
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:61192__%252Fm&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2}
status=0 QTime=2413
[junit4] 2> 771136 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.ZkShardTerms
Successful update of terms at /collections/collection1/terms/shard2 to
Terms{values={core_node4=0}, version=0}
[junit4] 2> 771136 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection1/leaders/shard2
[junit4] 2> 771158 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 771159 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 771159 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:61207/_/m/collection1_shard2_replica_n2/
[junit4] 2> 771159 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 771159 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.SyncStrategy
http://127.0.0.1:61207/_/m/collection1_shard2_replica_n2/ has no replicas
[junit4] 2> 771159 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection1/leaders/shard2/leader after winning as
/collections/collection1/leader_elect/shard2/election/72146532169154575-core_node4-n_0000000000
[junit4] 2> 771164 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:61207/_/m/collection1_shard2_replica_n2/ shard2
[junit4] 2> 771279 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
c:collection1 s:shard2 x:collection1_shard2_replica_n2 ] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 771299 INFO (qtp1047526932-11008) [n:127.0.0.1:61207__%2Fm
] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n2&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=2487
[junit4] 2> 771306 INFO (qtp1497717821-10890) [n:127.0.0.1:61120__%2Fm
c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null
path=/admin/collections
params={node=127.0.0.1:61207__%252Fm&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2}
status=0 QTime=2597
[junit4] 2> 772807 INFO
(OverseerThreadFactory-3224-thread-5-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd
Node Identified 127.0.0.1:61183__%2Fm for creating new replica of shard shard2
for collection collection1
[junit4] 2> 772808 INFO
(OverseerCollectionConfigSetProcessor-72146532169154564-127.0.0.1:61120__%2Fm-n_0000000000)
[n:127.0.0.1:61120__%2Fm ] 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> 772811 INFO
(OverseerThreadFactory-3224-thread-5-processing-n:127.0.0.1:61120__%2Fm)
[n:127.0.0.1:61120__%2Fm c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd
Returning CreateReplica command.
[junit4] 2> 772811 INFO
(OverseerCollectionConfigSetProcessor-72146532169154564-127.0.0.1:61120__%2Fm-n_00
[...truncated too long message...]
junit4] 2> 1737083 INFO (jetty-closer-7160-thread-1) [ ] o.e.j.s.session
node0 Stopped scavenging
[junit4] 2> 1737086 INFO
(SUITE-IndexSizeTriggerMixedBoundsTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 1737309 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 10
/solr/collections/testMixedBounds_collection/terms/shard2_1
[junit4] 2> 10
/solr/collections/testMixedBounds_collection/terms/shard1_1
[junit4] 2> 7
/solr/collections/testMixedBounds_collection/terms/shard1
[junit4] 2> 7
/solr/collections/testMixedBounds_collection/terms/shard2
[junit4] 2> 6
/solr/collections/testMixedBounds_collection/terms/shard2_0
[junit4] 2> 6
/solr/collections/testMixedBounds_collection/terms/shard1_0
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 2 /solr/packages.json
[junit4] 2> 2 /solr/security.json
[junit4] 2> 2
/solr/collections/testMixedBounds_collection/collectionprops.json
[junit4] 2> 2 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 230
/solr/collections/testMixedBounds_collection/state.json
[junit4] 2> 9 /solr/autoscaling.json
[junit4] 2> 4 /solr/clusterprops.json
[junit4] 2> 4 /solr/aliases.json
[junit4] 2> 4 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 92 /solr/overseer/queue
[junit4] 2> 9 /solr/overseer/collection-queue-work
[junit4] 2> 8 /solr/live_nodes
[junit4] 2> 7 /solr/collections
[junit4] 2> 4 /solr/autoscaling/events/index_size_trigger4
[junit4] 2>
[junit4] 2> 1737346 INFO
(SUITE-IndexSizeTriggerMixedBoundsTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:55422
[junit4] 2> 1737346 INFO
(SUITE-IndexSizeTriggerMixedBoundsTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:55422
[junit4] 2> 1737346 INFO
(SUITE-IndexSizeTriggerMixedBoundsTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 55422
[junit4] 2> 1737346 INFO
(SUITE-IndexSizeTriggerMixedBoundsTest-seed#[4A3EC542C6C014BF]-worker) [ ]
o.a.s.SolrTestCaseJ4 -------------------------------------------------------
Done waiting for tracked resources to be released
[junit4] 2> Apr 12, 2020 5:27:49 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Apr 12, 2020 5:28:00 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest:
[junit4] 2> 1) Thread[id=22204, name=SessionTracker,
state=TIMED_WAITING, group=TGRP-IndexSizeTriggerMixedBoundsTest]
[junit4] 2> at java.base@14/java.lang.Thread.sleep(Native Method)
[junit4] 2> at
app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
[junit4] 2> Apr 12, 2020 5:28:00 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=22204, name=SessionTracker,
state=TIMED_WAITING, group=TGRP-IndexSizeTriggerMixedBoundsTest]
[junit4] 2> 1747477 ERROR (SessionTracker) [ ]
o.a.z.s.ZooKeeperCriticalThread Severe unrecoverable error, from thread :
SessionTracker
[junit4] 2> => java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.base/java.lang.Thread.sleep(Native Method)
[junit4] 2> java.lang.InterruptedException: sleep interrupted
[junit4] 2> at java.lang.Thread.sleep(Native Method) [?:?]
[junit4] 2> at
org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
~[zookeeper-3.5.7.jar:3.5.7]
[junit4] 2> Apr 12, 2020 5:28:00 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene84):
{foo=Lucene84, _root_=PostingsFormat(name=Direct),
id=BlockTreeOrds(blocksize=128)}, docValues:{}, maxPointsInLeafNode=479,
maxMBSortInHeap=6.562175932839864,
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6f887675),
locale=ckb, timezone=Asia/Calcutta
[junit4] 2> NOTE: Mac OS X 10.14.6 x86_64/AdoptOpenJDK 14
(64-bit)/cpus=6,threads=1,free=253595856,total=506462208
[junit4] 2> NOTE: All tests run in this JVM: [TestScoreJoinQPScore,
ClusterStateMockUtilTest, TestDistribPackageStore, MissingSegmentRecoveryTest,
IndexSizeTriggerTest, HdfsUnloadDistributedZkTest,
TestCopyFieldCollectionResource, HLLSerializationTest, TestAnalyzedSuggestions,
TestObjectReleaseTracker, TestDirectoryFactory, ChaosMonkeySafeLeaderTest,
SimpleFacetsTest, TestSolrXml, SolrMetricsIntegrationTest, SyncSliceTest,
TestDistributedMap, TestPolicyCloud, TestStressUserVersions,
TestSchemalessBufferedUpdates, ExecutePlanActionTest, DeleteShardTest,
TestLuceneIndexBackCompat, DistributedFacetPivotSmallTest, TestCollectionAPIs,
TestShortCircuitedRequests, ResponseLogComponentTest,
TestPartialUpdateDeduplication, TestRequestStatusCollectionAPI,
SSLMigrationTest, DocValuesMultiTest, TestExportWriter, TestConfigSets,
LeaderVoteWaitTimeoutTest, TestPayloadCheckQParserPlugin, SOLR749Test,
JsonLoaderTest, TestSchemaVersionResource, FuzzySearchTest, InfoHandlerTest,
ZkShardTermsTest, TestNestedUpdateProcessor, CollectionsAPISolrJTest,
OverseerCollectionConfigSetProcessorTest, TestCloudDeleteByQuery,
SolrLogAuditLoggerPluginTest, TestInPlaceUpdateWithRouteField,
TestSolrCloudWithSecureImpersonation, MultiThreadedOCPTest,
AuditLoggerPluginTest, ConjunctionSolrSpellCheckerTest, TestSimpleTextCodec,
TestRandomRequestDistribution, TestJsonFacets, PolyFieldTest,
TestSearcherReuse, SolrCloudReportersTest, SuggesterFSTTest,
TestRandomDVFaceting, TestDistribIDF, TestRecovery, TestChildDocTransformer,
CollectionTooManyReplicasTest, TaggerTest, ReplaceNodeTest, TestMacros,
HighlighterMaxOffsetTest, TestInfoStreamLogging, TestValueSourceCache,
BasicDistributedZk2Test, OverseerStatusTest, TestComponentsName,
TestSimPolicyCloud, TestTlogReplica, TestDistributedStatsComponentCardinality,
HdfsBasicDistributedZkTest, TestFieldCacheReopen,
TestMultiValuedNumericRangeQuery, PluginInfoTest, TestSystemIdResolver,
TestPerFieldSimilarity, DefaultValueUpdateProcessorTest, InfixSuggestersTest,
TestPullReplica, DistributedQueryElevationComponentTest,
AnalysisErrorHandlingTest, TestHashQParserPlugin, AlternateDirectoryTest,
IgnoreCommitOptimizeUpdateProcessorFactoryTest, PeerSyncReplicationTest,
TestConfigSetsAPIExclusivity, TestExclusionRuleCollectionAccess,
TestLocalStatsCacheCloud, TestSSLRandomization, TestZkChroot,
ConcurrentDeleteAndCreateCollectionTest, CustomCollectionTest,
SimpleCollectionCreateDeleteTest, SplitByPrefixTest,
TestLocalFSCloudBackupRestore, IndexSizeTriggerMixedBoundsTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=IndexSizeTriggerMixedBoundsTest -Dtests.seed=4A3EC542C6C014BF
-Dtests.slow=true -Dtests.locale=ckb -Dtests.timezone=Asia/Calcutta
-Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] ERROR 0.00s J1 | IndexSizeTriggerMixedBoundsTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest:
[junit4] > 1) Thread[id=22204, name=SessionTracker,
state=TIMED_WAITING, group=TGRP-IndexSizeTriggerMixedBoundsTest]
[junit4] > at java.base@14/java.lang.Thread.sleep(Native Method)
[junit4] > at
app//org.apache.zookeeper.server.SessionTrackerImpl.run(SessionTrackerImpl.java:151)
[junit4] > at
__randomizedtesting.SeedInfo.seed([4A3EC542C6C014BF]:0)
[junit4] Completed [567/908 (2!)] on J1 in 58.22s, 1 test, 1 error <<<
FAILURES!
[...truncated 46005 lines...]
[repro] Jenkins log URL:
https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/5877/consoleText
[repro] Revision: 8c1f9815dbb01f0ac0b74b6fb0f4b07015105ab9
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
[repro] Repro line: ant test -Dtestcase=MultiThreadedOCPTest
-Dtests.method=test -Dtests.seed=4A3EC542C6C014BF -Dtests.slow=true
-Dtests.locale=qu-EC -Dtests.timezone=Asia/Macao -Dtests.asserts=true
-Dtests.file.encoding=UTF-8
[repro] Repro line: ant test -Dtestcase=IndexSizeTriggerMixedBoundsTest
-Dtests.seed=4A3EC542C6C014BF -Dtests.slow=true -Dtests.locale=ckb
-Dtests.timezone=Asia/Calcutta -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] JUnit rest result XML files will be moved to: ./repro-reports
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] MultiThreadedOCPTest
[repro] IndexSizeTriggerMixedBoundsTest
[repro] ant compile-test
[...truncated 3187 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=10
-Dtests.class="*.MultiThreadedOCPTest|*.IndexSizeTriggerMixedBoundsTest"
-Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseG1GC"
-Dtests.seed=4A3EC542C6C014BF -Dtests.slow=true -Dtests.locale=qu-EC
-Dtests.timezone=Asia/Macao -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 106 lines...]
[repro] Failures w/original seeds:
[repro] 0/5 failed: org.apache.solr.cloud.MultiThreadedOCPTest
[repro] 0/5 failed:
org.apache.solr.cloud.autoscaling.IndexSizeTriggerMixedBoundsTest
[repro] Exiting with code 0
[...truncated 73 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
