You are viewing a plain text version of this content. The canonical link for it is here.
Posted to builds@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/11/04 10:58:56 UTC
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk-11.0.4) - Build # 401 -
Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/401/
Java: 64bit/jdk-11.0.4 -XX:-UseCompressedOops -XX:+UseG1GC
1 tests failed.
FAILED: org.apache.solr.cloud.SyncSliceTest.test
Error Message:
expected:<5> but was:<4>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<4>
at __randomizedtesting.SeedInfo.seed([DBE234F834B05BF9:53B60B229A4C3601]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.SyncSliceTest.test(SyncSliceTest.java:150)
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:566)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
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:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:834)
Build Log:
[...truncated 14925 lines...]
[junit4] Suite: org.apache.solr.cloud.SyncSliceTest
[junit4] 2> 2742149 INFO (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 2742149 INFO (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-worker) [ ] o.a.s.SolrTestCaseJ4 Created dataDir: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/data-dir-235-001
[junit4] 2> 2742149 WARN (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=30 numCloses=30
[junit4] 2> 2742150 INFO (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 2742151 INFO (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-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> 2742151 INFO (SUITE-SyncSliceTest-seed#[DBE234F834B05BF9]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /
[junit4] 2> 2742154 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2742154 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2742154 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2742260 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer start zk server on port:51970
[junit4] 2> 2742261 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:51970
[junit4] 2> 2742261 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:51970
[junit4] 2> 2742261 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 51970
[junit4] 2> 2742269 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2742281 INFO (zkConnectionManagerCallback-15565-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2742281 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2742288 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2742290 INFO (zkConnectionManagerCallback-15567-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2742290 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2742292 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig-tlog.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 2742297 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/schema.xml to /configs/conf1/schema.xml
[junit4] 2> 2742301 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 2742303 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 2742306 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 2742308 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 2742311 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 2742313 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 2742316 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 2742318 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 2742332 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer put /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 2742334 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 2742789 WARN (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2742789 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2742789 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2742790 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+11
[junit4] 2> 2742791 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2742791 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2742791 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2742792 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@d5545a{/,null,AVAILABLE}
[junit4] 2> 2742792 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@463b836c{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:51974}
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.s.Server Started @2742848ms
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/tempDir-001/control/data, hostPort=51974, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/control-001/cores, replicaType=NRT}
[junit4] 2> 2742793 ERROR (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2742793 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-04T10:02:25.440904Z
[junit4] 2> 2742795 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2742797 INFO (zkConnectionManagerCallback-15569-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2742797 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2742902 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2742903 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/control-001/solr.xml
[junit4] 2> 2742908 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2742908 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2742909 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2743128 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2743129 WARN (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@3e7753e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743129 WARN (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@3e7753e9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743132 WARN (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@53007dfc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743132 WARN (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@53007dfc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2743132 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51970/solr
[junit4] 2> 2743133 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2743136 INFO (zkConnectionManagerCallback-15576-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2743136 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2743249 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2743252 INFO (zkConnectionManagerCallback-15578-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2743252 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2743470 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:51974_
[junit4] 2> 2743472 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.Overseer Overseer (id=72074993402314756-127.0.0.1:51974_-n_0000000000) starting
[junit4] 2> 2743494 INFO (OverseerStateUpdate-72074993402314756-127.0.0.1:51974_-n_0000000000) [n:127.0.0.1:51974_ ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:51974_
[junit4] 2> 2743495 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:51974_
[junit4] 2> 2743502 INFO (zkCallback-15577-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2743539 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2743562 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2743583 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2743583 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2743585 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [n:127.0.0.1:51974_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/control-001/cores
[junit4] 2> 2743617 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2743627 INFO (zkConnectionManagerCallback-15587-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2743627 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2743630 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2743633 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51970/solr ready
[junit4] 2> 2743636 INFO (qtp1767892701-42047) [n:127.0.0.1:51974_ ] 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:51974_&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2743643 INFO (OverseerThreadFactory-13420-thread-1-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 2743758 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2743758 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ x:control_collection_shard1_replica_n1 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2744846 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2744875 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=test
[junit4] 2> 2744978 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745008 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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 collection control_collection, trusted=true
[junit4] 2> 2745008 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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@db6a5b4
[junit4] 2> 2745008 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 2745010 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=927507371, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2745011 WARN (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745058 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745058 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745059 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2745059 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2745059 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6785288206701976]
[junit4] 2> 2745059 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@8614a20[control_collection_shard1_replica_n1] main]
[junit4] 2> 2745065 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2745066 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745067 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2745067 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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 1649265079970955264
[junit4] 2> 2745075 INFO (searcherExecutor-13425-thread-1-processing-n:127.0.0.1:51974_ x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:51974_ 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@8614a20[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2745317 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745317 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745323 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2745323 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745323 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:51974/control_collection_shard1_replica_n1/
[junit4] 2> 2745324 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745325 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:51974/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 2745325 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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/72074993402314756-core_node2-n_0000000000
[junit4] 2> 2745329 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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:51974/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 2745443 INFO (zkCallback-15577-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> 2745443 INFO (zkCallback-15577-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> 2745443 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ 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> 2745450 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ c:control_collection s:shard1 x:control_collection_shard1_replica_n1 ] 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=1692
[junit4] 2> 2745454 INFO (qtp1767892701-42047) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2745551 INFO (zkCallback-15577-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> 2745551 INFO (zkCallback-15577-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> 2745551 INFO (zkCallback-15577-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> 2745552 INFO (qtp1767892701-42047) [n:127.0.0.1:51974_ ] 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:51974_&wt=javabin&version=2} status=0 QTime=1916
[junit4] 2> 2745553 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Waiting to see 1 active replicas in collection: control_collection
[junit4] 2> 2745669 INFO (OverseerCollectionConfigSetProcessor-72074993402314756-127.0.0.1:51974_-n_0000000000) [n:127.0.0.1:51974_ ] 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> 2745671 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2745673 INFO (zkConnectionManagerCallback-15593-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2745673 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2745676 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2745678 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:51970/solr ready
[junit4] 2> 2745678 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 2745680 INFO (qtp1767892701-42048) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=1&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2745685 INFO (OverseerThreadFactory-13420-thread-2-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 2745903 WARN (OverseerThreadFactory-13420-thread-2-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 2745908 INFO (qtp1767892701-42048) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 2745910 INFO (qtp1767892701-42048) [n:127.0.0.1:51974_ ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=1&createNodeSet=&stateFormat=1&wt=javabin&version=2} status=0 QTime=230
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active slice count: 1 expected:1
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.SolrCloudTestCase active replica count: 0 expected replica count: 0
[junit4] 2> 2745912 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=4
[junit4] 2> 2746355 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001 of type NRT
[junit4] 2> 2746356 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2746357 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2746357 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2746357 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+11
[junit4] 2> 2746359 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2746359 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2746361 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2746362 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@cc5370c{/,null,AVAILABLE}
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1b397857{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52004}
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server Started @2746418ms
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/tempDir-001/jetty1, hostPort=52004, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001/cores, replicaType=NRT}
[junit4] 2> 2746363 ERROR (closeThreadPool-15594-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2746363 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-04T10:02:29.010609Z
[junit4] 2> 2746364 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2746367 INFO (zkConnectionManagerCallback-15596-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2746367 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2746471 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2746471 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001/solr.xml
[junit4] 2> 2746473 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2746473 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2746474 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2746679 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2746680 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@160c7f5e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2746681 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@160c7f5e[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2746700 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@26d38c74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2746700 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@26d38c74[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2746701 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51970/solr
[junit4] 2> 2746703 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2746706 INFO (zkConnectionManagerCallback-15603-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2746706 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2746814 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2746815 INFO (zkConnectionManagerCallback-15605-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2746815 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2746831 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2746847 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.ZkController Publish node=127.0.0.1:52004_ as DOWN
[junit4] 2> 2746849 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2746849 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52004_
[junit4] 2> 2746852 INFO (zkCallback-15577-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2746852 INFO (zkCallback-15592-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2746853 INFO (zkCallback-15604-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 2746885 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2746905 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2746949 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2746949 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2746953 INFO (closeThreadPool-15594-thread-1) [n:127.0.0.1:52004_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001/cores
[junit4] 2> 2746994 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:52004_
[junit4] 2> 2747122 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001 of type NRT
[junit4] 2> 2747123 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2747123 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2747123 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2747123 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+11
[junit4] 2> 2747124 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2747124 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2747124 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5080fea{/,null,AVAILABLE}
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1fe500d0{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52011}
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server Started @2747181ms
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/tempDir-001/jetty2, hostPort=52011, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001/cores, replicaType=NRT}
[junit4] 2> 2747125 ERROR (closeThreadPool-15594-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2747125 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 2747126 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2747126 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2747126 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-04T10:02:29.773167Z
[junit4] 2> 2747127 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2747129 INFO (zkConnectionManagerCallback-15611-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2747129 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2747234 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2747235 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001/solr.xml
[junit4] 2> 2747265 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2747265 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2747266 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2747398 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2747399 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@60fe755c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2747399 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@60fe755c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2747406 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@76fa0ba3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2747406 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@76fa0ba3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2747407 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51970/solr
[junit4] 2> 2747411 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2747413 INFO (zkConnectionManagerCallback-15618-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2747413 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2747526 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2747527 INFO (zkConnectionManagerCallback-15620-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2747527 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2747541 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 2747553 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:52011_ as DOWN
[junit4] 2> 2747557 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2747557 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52011_
[junit4] 2> 2747572 INFO (zkCallback-15577-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2747572 INFO (zkCallback-15604-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2747572 INFO (zkCallback-15592-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2747573 INFO (zkCallback-15619-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 2747631 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2747675 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2747696 INFO (OverseerCollectionConfigSetProcessor-72074993402314756-127.0.0.1:51974_-n_0000000000) [n:127.0.0.1:51974_ ] 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> 2747699 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2747699 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2747701 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001/cores
[junit4] 2> 2747769 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:52011_
[junit4] 2> 2747885 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-3-001 of type NRT
[junit4] 2> 2747885 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2747885 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2747885 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2747885 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+11
[junit4] 2> 2747887 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2747887 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2747887 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2747887 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@626c7ef7{/,null,AVAILABLE}
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@344b4fc6{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52020}
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.e.j.s.Server Started @2747943ms
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/tempDir-001/jetty3, hostPort=52020, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-3-001/cores}
[junit4] 2> 2747888 ERROR (closeThreadPool-15594-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2747888 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-04T10:02:30.535893Z
[junit4] 2> 2747889 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2747892 INFO (zkConnectionManagerCallback-15626-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2747892 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2747995 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2747995 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-3-001/solr.xml
[junit4] 2> 2747998 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2747998 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2747999 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2748243 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2748244 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@2268c32c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748244 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@2268c32c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748246 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@145525c5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748247 WARN (closeThreadPool-15594-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@145525c5[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748248 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51970/solr
[junit4] 2> 2748249 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2748251 INFO (zkConnectionManagerCallback-15633-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2748251 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2748347 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-4-001 of type NRT
[junit4] 2> 2748348 WARN (closeThreadPool-15594-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2748348 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2748348 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2748348 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 11.0.4+11
[junit4] 2> 2748350 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2748350 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2748350 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 2748350 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@380c4323{/,null,AVAILABLE}
[junit4] 2> 2748350 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5340f573{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:52025}
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.e.j.s.Server Started @2748406ms
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/, solrconfig=solrconfig.xml, solr.data.dir=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/tempDir-001/jetty4, hostPort=52025, coreRootDirectory=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-4-001/cores, replicaType=NRT}
[junit4] 2> 2748351 ERROR (closeThreadPool-15594-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.4.0
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2748351 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-04T10:02:30.998474Z
[junit4] 2> 2748352 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2748354 INFO (zkConnectionManagerCallback-15635-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2748354 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2748356 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2748359 INFO (zkConnectionManagerCallback-15637-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2748359 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2748369 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 2748378 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:52020_ as DOWN
[junit4] 2> 2748380 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2748380 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52020_
[junit4] 2> 2748383 INFO (zkCallback-15604-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2748383 INFO (zkCallback-15577-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2748383 INFO (zkCallback-15592-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2748383 INFO (zkCallback-15619-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2748383 INFO (zkCallback-15636-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 2748411 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2748435 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748448 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748448 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748450 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-3-001/cores
[junit4] 2> 2748463 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 2748463 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-4-001/solr.xml
[junit4] 2> 2748466 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 2748466 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 2748468 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 2748500 INFO (closeThreadPool-15594-thread-1) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:52020_
[junit4] 2> 2748703 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 2748704 WARN (closeThreadPool-15594-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@c7ad9a9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748704 WARN (closeThreadPool-15594-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@c7ad9a9[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748706 WARN (closeThreadPool-15594-thread-2) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@167cf1ca[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748706 WARN (closeThreadPool-15594-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@167cf1ca[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2748707 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:51970/solr
[junit4] 2> 2748708 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2748710 INFO (zkConnectionManagerCallback-15648-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2748710 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2748817 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2748820 INFO (zkConnectionManagerCallback-15650-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2748820 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2748831 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 2748840 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.ZkController Publish node=127.0.0.1:52025_ as DOWN
[junit4] 2> 2748842 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 2748843 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:52025_
[junit4] 2> 2748846 INFO (zkCallback-15619-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748846 INFO (zkCallback-15604-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748846 INFO (zkCallback-15592-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748846 INFO (zkCallback-15636-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748846 INFO (zkCallback-15577-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748846 INFO (zkCallback-15649-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 2748869 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2748901 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748922 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748923 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2748924 INFO (closeThreadPool-15594-thread-2) [n:127.0.0.1:52025_ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-4-001/cores
[junit4] 2> 2748978 INFO (closeThreadPool-15594-thread-2) [ ] o.a.s.c.AbstractFullDistribZkTestBase waitForLiveNode: 127.0.0.1:52025_
[junit4] 2> 2748985 INFO (qtp1767892701-42047) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:52004_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2748986 INFO (qtp1767892701-42050) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:52011_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2748986 INFO (qtp1767892701-42048) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:52025_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2748986 INFO (qtp1767892701-42049) [n:127.0.0.1:51974_ ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:52020_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2748994 INFO (OverseerThreadFactory-13420-thread-3-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:52004_ for creating new replica of shard shard1 for collection collection1
[junit4] 2> 2748998 INFO (OverseerThreadFactory-13420-thread-3-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2749004 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750038 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2750056 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
[junit4] 2> 2750252 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750285 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true
[junit4] 2> 2750286 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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@db6a5b4
[junit4] 2> 2750286 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001/cores/collection1_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/../../../../../../../../../Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-1-001/cores/collection1_shard1_replica_n1/data/]
[junit4] 2> 2750289 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=927507371, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2750291 WARN (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750470 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2750471 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750473 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2750473 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2750474 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6785288206701976]
[junit4] 2> 2750475 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@643626e8[collection1_shard1_replica_n1] main]
[junit4] 2> 2750478 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 2750479 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750479 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2750479 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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 1649265085645848576
[junit4] 2> 2750483 INFO (searcherExecutor-13466-thread-1-processing-n:127.0.0.1:52004_ x:collection1_shard1_replica_n1 c:collection1 s:shard1) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher Searcher@643626e8[collection1_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2750489 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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_node2=0}, version=0}
[junit4] 2> 2750489 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750495 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 2750496 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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> 2750496 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:52004/collection1_shard1_replica_n1/
[junit4] 2> 2750496 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 2750496 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.SyncStrategy http://127.0.0.1:52004/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 2750496 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ 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/72074993402314761-core_node2-n_0000000000
[junit4] 2> 2750498 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:52004/collection1_shard1_replica_n1/ shard1
[junit4] 2> 2750604 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 2750608 INFO (qtp520552303-42103) [n:127.0.0.1:52004_ c:collection1 s:shard1 x:collection1_shard1_replica_n1 ] 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=1604
[junit4] 2> 2750612 INFO (qtp1767892701-42047) [n:127.0.0.1:51974_ c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:52004_&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=1627
[junit4] 2> 2750999 INFO (OverseerThreadFactory-13420-thread-4-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:52011_ for creating new replica of shard shard1 for collection collection1
[junit4] 2> 2751000 INFO (OverseerCollectionConfigSetProcessor-72074993402314756-127.0.0.1:51974_-n_0000000000) [n:127.0.0.1:51974_ ] 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> 2751001 INFO (OverseerThreadFactory-13420-thread-4-processing-n:127.0.0.1:51974_) [n:127.0.0.1:51974_ c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 2751008 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ x:collection1_shard1_replica_n3 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n3&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2752034 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2752053 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n3] Schema name=test
[junit4] 2> 2752201 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.s.IndexSchema Loaded schema test/1.0 with uniqueid field id
[junit4] 2> 2752236 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n3' using configuration from collection collection1, trusted=true
[junit4] 2> 2752237 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_n3' (registry 'solr.core.collection1.shard1.replica_n3') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@db6a5b4
[junit4] 2> 2752237 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n3] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001/cores/collection1_shard1_replica_n3], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001/shard-2-001/cores/collection1_shard1_replica_n3/data/]
[junit4] 2> 2752239 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=927507371, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 2752241 WARN (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] 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> 2752343 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2752343 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2752346 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2752346 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2752365 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.LogByteSizeMergePolicy: [LogByteSizeMergePolicy: minMergeSize=1677721, mergeFactor=20, maxMergeSize=2147483648, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.6785288206701976]
[junit4] 2> 2752366 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_replica_n3 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5bb61ac7[collection1_shard1_replica_n3] main]
[junit4] 2> 2752370 INFO (qtp1062758304-42135) [n:127.0.0.1:52011_ c:collection1 s:shard1 x:collection1_shard1_r
[...truncated too long message...]
7 /solr/clusterprops.json
[junit4] 2> 2 /solr/overseer_elect/election/72074993402314756-127.0.0.1:51974_-n_0000000000
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 49 /solr/overseer/queue
[junit4] 2> 34 /solr/live_nodes
[junit4] 2> 17 /solr/overseer/collection-queue-work
[junit4] 2> 7 /solr/collections
[junit4] 2>
[junit4] 2> 2770035 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:51970
[junit4] 2> 2770035 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:51970
[junit4] 2> 2770035 INFO (TEST-SyncSliceTest.test-seed#[DBE234F834B05BF9]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 51970
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SyncSliceTest -Dtests.method=test -Dtests.seed=DBE234F834B05BF9 -Dtests.slow=true -Dtests.locale=es-PR -Dtests.timezone=Asia/Yakutsk -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 28.1s J1 | SyncSliceTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: expected:<5> but was:<4>
[junit4] > at __randomizedtesting.SeedInfo.seed([DBE234F834B05BF9:53B60B229A4C3601]:0)
[junit4] > at org.apache.solr.cloud.SyncSliceTest.test(SyncSliceTest.java:150)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4] > at java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
[junit4] > at java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
[junit4] > at java.base/java.lang.reflect.Method.invoke(Method.java:566)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsFixedStatement.callStatement(BaseDistributedSearchTestCase.java:1082)
[junit4] > at org.apache.solr.BaseDistributedSearchTestCase$ShardsRepeatRule$ShardsStatement.evaluate(BaseDistributedSearchTestCase.java:1054)
[junit4] > at java.base/java.lang.Thread.run(Thread.java:834)
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J1/temp/solr.cloud.SyncSliceTest_DBE234F834B05BF9-001
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@565fb618), locale=es-PR, timezone=Asia/Yakutsk
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/AdoptOpenJDK 11.0.4 (64-bit)/cpus=3,threads=1,free=226338736,total=536870912
[junit4] 2> NOTE: All tests run in this JVM: [TemplateUpdateProcessorTest, UniqFieldsUpdateProcessorFactoryTest, OverseerModifyCollectionTest, SolrCLIZkUtilsTest, NoCacheHeaderTest, ChaosMonkeyNothingIsSafeTest, LeaderFailureAfterFreshStartTest, HdfsWriteToMultipleCollectionsTest, SignificantTermsQParserPluginTest, TestHalfAndHalfDocValues, RulesTest, TestSkipOverseerOperations, ManagedSchemaRoundRobinCloudTest, SuggestComponentTest, TimeZoneUtilsTest, TestSolrCloudSnapshots, HdfsDirectoryTest, TestFieldCache, SimpleCollectionCreateDeleteTest, JWTAuthPluginIntegrationTest, TestAnalyzedSuggestions, FacetPivotSmallTest, TestTrie, CursorPagingTest, CircularListTest, TestDistribDocBasedVersion, TestInfoStreamLogging, TestCloudManagedSchema, TestLegacyFieldReuse, TestOmitPositions, TestManagedSynonymGraphFilterFactory, TestCloudPseudoReturnFields, TestDeprecatedFilters, SSLMigrationTest, SpellCheckCollatorWithCollapseTest, JavabinLoaderTest, TestFieldCacheVsDocValues, TestExtendedDismaxParser, TestQuerySenderListener, AtomicUpdateRemovalJavabinTest, CdcrBidirectionalTest, TestSimpleTextCodec, TestShortCircuitedRequests, TestReplicationHandlerBackup, URLClassifyProcessorTest, TestAtomicUpdateErrorCases, TestGeoJSONResponseWriter, TestHttpServletCarrier, TestSimDistributedQueue, StatsReloadRaceTest, NodeMarkersRegistrationTest, HealthCheckHandlerTest, TestHttpShardHandlerFactory, HLLSerializationTest, OverseerTest, SolrXmlInZkTest, TimeRoutedAliasUpdateProcessorTest, ConcurrentDeleteAndCreateCollectionTest, FileUtilsTest, TestJmxIntegration, SmileWriterTest, DistributedQueueTest, ConnectionManagerTest, TestDFRSimilarityFactory, TestReqParamsAPI, TestPullReplicaErrorHandling, TaggerTest, DistributedSuggestComponentTest, TestMinHashQParser, TestManagedSchemaAPI, SolrCoreTest, TestInPlaceUpdatesStandalone, AssignTest, CurrencyFieldTypeTest, TestSerializedLuceneMatchVersion, RequestHandlersTest, TestCursorMarkWithoutUniqueKey, HdfsTlogReplayBufferedWhileIndexingTest, CdcrRequestHandlerTest, CdcrWithNodesRestartsTest, TestRecoveryHdfs, GraphQueryTest, CoreAdminHandlerTest, TestRTGBase, TestXIncludeConfig, DistributedIntervalFacetingTest, TestLegacyFieldCache, TestInPlaceUpdatesDistrib, UnloadDistributedZkTest, ReplaceNodeNoTargetTest, QueryResultKeyTest, TestSolrIndexConfig, CreateRoutedAliasTest, TestEmbeddedSolrServerAdminHandler, TestSha256AuthenticationProvider, SolrRequestParserTest, CategoryRoutedAliasUpdateProcessorTest, TestSurroundQueryParser, TestHdfsUpdateLog, CollectionsAPIAsyncDistributedZkTest, SolrLogAuditLoggerPluginTest, TestCaffeineCache, CloudExitableDirectoryReaderTest, SolrCmdDistributorTest, CdcrUpdateLogTest, TestComponentsName, LeaderVoteWaitTimeoutTest, UpdateParamsTest, TestIndexSearcher, XsltUpdateRequestHandlerTest, TestSolr4Spatial2, DateMathParserTest, TestComplexPhraseLeadingWildcard, TestLRUStatsCache, TestCryptoKeys, ChaosMonkeySafeLeaderTest, SharedFSAutoReplicaFailoverTest, TestStressLiveNodes, XmlInterpolationTest, NodeLostTriggerIntegrationTest, TestSweetSpotSimilarityFactory, TestScoreJoinQPScore, TestQueryTypes, TestStandardQParsers, JvmMetricsTest, TestGraphTermsQParserPlugin, TestConfigSetsAPIExclusivity, TestCoreDiscovery, TestEmbeddedSolrServerSchemaAPI, TestSchemaManager, PeerSyncWithBufferUpdatesTest, RangeFacetCloudTest, OverriddenZkACLAndCredentialsProvidersTest, ZkFailoverTest, SegmentsInfoRequestHandlerTest, TestConfig, TestClusterProperties, TestMiniSolrCloudClusterSSL, AssignBackwardCompatibilityTest, ZkCLITest, DistributedFacetPivotLargeTest, BasicFunctionalityTest, TestPolicyCloud, MoveReplicaHDFSFailoverTest, RecoveryAfterSoftCommitTest, DistributedExpandComponentTest, TestSchemaNameResource, TestBulkSchemaAPI, MoreLikeThisComponentTest, TestFieldCacheSort, SolrTestCaseJ4Test, TestFiltering, TestSmileRequest, ShardsWhitelistTest, ExecutePlanActionTest, TestSolrTestCaseJ4, TestAuthenticationFramework, TestDocumentBuilder, TestPhraseSuggestions, TestTrackingShardHandlerFactory, TermVectorComponentTest, SampleTest, MoveReplicaTest, EnumFieldTest, TestExactSharedStatsCache, DimensionalRoutedAliasUpdateProcessorTest, HdfsDirectoryFactoryTest, TestSortByMinMaxFunction, TestUtilizeNode, TestCustomStream, XMLAtomicUpdateMultivalueTest, CSVRequestHandlerTest, WordBreakSolrSpellCheckerTest, RollingRestartTest, ByteBuffersDirectoryFactoryTest, PropertiesRequestHandlerTest, BlockDirectoryTest, HdfsRecoveryZkTest, JavaBinAtomicUpdateMultivalueTest, TestExportTool, RegexBoostProcessorTest, TestSystemCollAutoCreate, InfoHandlerTest, TestWriterPerf, TestStreamBody, SimpleFacetsTest, CollectionStateFormat2Test, CurrencyRangeFacetCloudTest, HighlighterConfigTest, TestSimComputePlanAction, AddReplicaTest, TestStressRecovery, DirectSolrConnectionTest, TestHighlightDedupGrouping, DocExpirationUpdateProcessorFactoryTest, TestReloadDeadlock, SuggesterTSTTest, TestLFUCache, ShardRoutingCustomTest, BigEndianAscendingWordSerializerTest, DeleteStatusTest, MoreLikeThisHandlerTest, QueryElevationComponentTest, ResponseLogComponentTest, TestHdfsCloudBackupRestore, LargeFieldTest, V2StandaloneTest, TestClassicSimilarityFactory, ForceLeaderWithTlogReplicasTest, TestRTimerTree, ParsingFieldUpdateProcessorsTest, TestHdfsBackupRestoreCore, TestLegacyTerms, HdfsSyncSliceTest, TestBinaryField, EchoParamsTest, MinimalSchemaTest, TestDistributedGrouping, TestDistributedMissingSort, TestJoin, TestRandomDVFaceting, TestRandomFaceting, TestSimpleTrackingShardHandler, PathHierarchyTokenizerFactoryTest, ProtectedTermFilterFactoryTest, TestLuceneMatchVersion, TestReversedWildcardFilterFactory, TestWordDelimiterFilterFactory, TokenizerChainTest, TestJettySolrRunner, ConnectionReuseTest, BasicDistributedZk2Test, BasicDistributedZkTest, ChaosMonkeySafeLeaderWithPullReplicasTest, ClusterStateTest, ClusterStateUpdateTest, CollectionsAPISolrJTest, DistributedVersionInfoTest, HttpPartitionOnCommitTest, HttpPartitionWithTlogReplicasTest, LeaderElectionTest, MigrateRouteKeyTest, RecoveryZkTest, ReplaceNodeTest, ReplicationFactorTest, SplitShardTest, SyncSliceTest]
[junit4] Completed [494/880 (1!)] on J1 in 28.13s, 1 test, 1 failure <<< FAILURES!
[...truncated 46053 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/401/consoleText
[repro] Revision: c3b8b584bf76e5bffda070d7ac704106fbd978f9
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line: ant test -Dtestcase=SyncSliceTest -Dtests.method=test -Dtests.seed=DBE234F834B05BF9 -Dtests.slow=true -Dtests.locale=es-PR -Dtests.timezone=Asia/Yakutsk -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] SyncSliceTest
[repro] ant compile-test
[...truncated 3614 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.SyncSliceTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=DBE234F834B05BF9 -Dtests.slow=true -Dtests.locale=es-PR -Dtests.timezone=Asia/Yakutsk -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 72 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.SyncSliceTest
[repro] Exiting with code 0
[...truncated 73 lines...]
[JENKINS] Lucene-Solr-8.x-MacOSX (64bit/jdk-13) - Build # 402 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-MacOSX/402/
Java: 64bit/jdk-13 -XX:+UseCompressedOops -XX:+UseSerialGC
5 tests failed.
FAILED: org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering
Error Message:
expected:<5> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<1>
at __randomizedtesting.SeedInfo.seed([60F3156584C18AA2:F09CF4BF2A769B59]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering(ZkShardTermsTest.java:143)
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:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
FAILED: org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering
Error Message:
expected:<5> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<1>
at __randomizedtesting.SeedInfo.seed([60F3156584C18AA2:F09CF4BF2A769B59]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering(ZkShardTermsTest.java:143)
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:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
FAILED: org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering
Error Message:
expected:<5> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<1>
at __randomizedtesting.SeedInfo.seed([60F3156584C18AA2:F09CF4BF2A769B59]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering(ZkShardTermsTest.java:143)
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:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
FAILED: org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering
Error Message:
expected:<5> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<1>
at __randomizedtesting.SeedInfo.seed([60F3156584C18AA2:F09CF4BF2A769B59]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering(ZkShardTermsTest.java:143)
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:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
FAILED: org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering
Error Message:
expected:<5> but was:<1>
Stack Trace:
java.lang.AssertionError: expected:<5> but was:<1>
at __randomizedtesting.SeedInfo.seed([60F3156584C18AA2:F09CF4BF2A769B59]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.failNotEquals(Assert.java:834)
at org.junit.Assert.assertEquals(Assert.java:645)
at org.junit.Assert.assertEquals(Assert.java:631)
at org.apache.solr.cloud.ZkShardTermsTest.testCoreRemovalWhileRecovering(ZkShardTermsTest.java:143)
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:567)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1750)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:938)
at com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:974)
at com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:988)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:947)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:832)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:883)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:894)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
at java.base/java.lang.Thread.run(Thread.java:830)
Build Log:
[...truncated 15085 lines...]
[junit4] Suite: org.apache.solr.cloud.ZkShardTermsTest
[junit4] 2> 2949515 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.MiniSolrCloudCluster Starting cluster of 1 servers in /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001
[junit4] 2> 2949516 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 2949516 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 2949516 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 2949626 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer start zk server on port:58987
[junit4] 2> 2949626 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer waitForServerUp: 127.0.0.1:58987
[junit4] 2> 2949626 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:58987
[junit4] 2> 2949626 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 58987
[junit4] 2> 2949628 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2949639 INFO (zkConnectionManagerCallback-18641-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2949639 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2949645 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2949647 INFO (zkConnectionManagerCallback-18643-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2949648 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2949648 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2949651 INFO (zkConnectionManagerCallback-18645-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2949651 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2949765 WARN (jetty-launcher-18646-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 2949765 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (configured port=0, binding port=0)
[junit4] 2> 2949765 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 2949765 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.Server jetty-9.4.19.v20190610; built: 2019-06-10T16:30:51.723Z; git: afcf563148970e98786327af5e07c261fda175d3; jvm 13+33
[junit4] 2> 2949767 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 2949767 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 2949767 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 2949767 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@47930bff{/solr,null,AVAILABLE}
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@52528f6b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:58992}
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.e.j.s.Server Started @2949813ms
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, hostPort=58992}
[junit4] 2> 2949768 ERROR (jetty-launcher-18646-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version 8.4.0
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 2949768 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-11-05T03:53:51.353593Z
[junit4] 2> 2949769 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2949771 INFO (zkConnectionManagerCallback-18648-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2949772 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2949772 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 2949928 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2949929 WARN (jetty-launcher-18646-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@669f9c85[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2949929 WARN (jetty-launcher-18646-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@669f9c85[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2949940 WARN (jetty-launcher-18646-thread-1) [ ] o.e.j.u.s.S.config Trusting all certificates configured for Client@6a0d91e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2949940 WARN (jetty-launcher-18646-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for Client@6a0d91e2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2949941 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58987/solr
[junit4] 2> 2949942 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2949944 INFO (zkConnectionManagerCallback-18655-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2949944 INFO (jetty-launcher-18646-thread-1) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2950058 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2950061 INFO (zkConnectionManagerCallback-18657-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2950061 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2950229 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58992_solr
[junit4] 2> 2950234 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.Overseer Overseer (id=72079206470123525-127.0.0.1:58992_solr-n_0000000000) starting
[junit4] 2> 2950244 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:58992_solr
[junit4] 2> 2950244 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:58992_solr
[junit4] 2> 2950247 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2950267 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2950289 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2950298 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2950298 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2950299 INFO (jetty-launcher-18646-thread-1) [n:127.0.0.1:58992_solr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/.
[junit4] 2> 2950310 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.MiniSolrCloudCluster waitForAllNodes: numServers=1
[junit4] 2> 2950311 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Waiting for client to connect to ZooKeeper
[junit4] 2> 2950314 INFO (zkConnectionManagerCallback-18666-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 2950314 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ConnectionManager Client is connected to ZooKeeper
[junit4] 2> 2950316 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 2950319 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58987/solr ready
[junit4] 2> 2950391 INFO (TEST-ZkShardTermsTest.testParticipationOfReplicas-seed#[60F3156584C18AA2]) [ ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={replica1=0}, version=0}
[junit4] 2> 2950392 INFO (TEST-ZkShardTermsTest.testParticipationOfReplicas-seed#[60F3156584C18AA2]) [ ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={replica1=0, replica2=0}, version=1}
[junit4] 2> 2950392 INFO (TEST-ZkShardTermsTest.testParticipationOfReplicas-seed#[60F3156584C18AA2]) [ ] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={replica1=1, replica2=0}, version=2}
[junit4] 2> 2950394 INFO (qtp1553300105-49202) [n:127.0.0.1:58992_solr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params pullReplicas=0&maxShardsPerNode=1000&name=collection1&nrtReplicas=2&action=CREATE&numShards=2&tlogReplicas=0&createNodeSet=127.0.0.1:58992_solr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 2950399 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 2950401 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/managed-schema to /configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 2950404 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/protwords.txt to /configs/collection1.AUTOCREATED/protwords.txt
[junit4] 2> 2950407 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/solrconfig.xml to /configs/collection1.AUTOCREATED/solrconfig.xml
[junit4] 2> 2950410 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/synonyms.txt to /configs/collection1.AUTOCREATED/synonyms.txt
[junit4] 2> 2950412 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/stopwords.txt to /configs/collection1.AUTOCREATED/stopwords.txt
[junit4] 2> 2950416 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_it.txt to /configs/collection1.AUTOCREATED/lang/contractions_it.txt
[junit4] 2> 2950419 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ca.txt to /configs/collection1.AUTOCREATED/lang/contractions_ca.txt
[junit4] 2> 2950421 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stemdict_nl.txt to /configs/collection1.AUTOCREATED/lang/stemdict_nl.txt
[junit4] 2> 2950428 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hy.txt to /configs/collection1.AUTOCREATED/lang/stopwords_hy.txt
[junit4] 2> 2950431 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_no.txt to /configs/collection1.AUTOCREATED/lang/stopwords_no.txt
[junit4] 2> 2950434 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_id.txt to /configs/collection1.AUTOCREATED/lang/stopwords_id.txt
[junit4] 2> 2950437 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_et.txt to /configs/collection1.AUTOCREATED/lang/stopwords_et.txt
[junit4] 2> 2950440 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_da.txt to /configs/collection1.AUTOCREATED/lang/stopwords_da.txt
[junit4] 2> 2950444 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ga.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ga.txt
[junit4] 2> 2950447 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hi.txt to /configs/collection1.AUTOCREATED/lang/stopwords_hi.txt
[junit4] 2> 2950450 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ja.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ja.txt
[junit4] 2> 2950454 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_pt.txt to /configs/collection1.AUTOCREATED/lang/stopwords_pt.txt
[junit4] 2> 2950457 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_hu.txt to /configs/collection1.AUTOCREATED/lang/stopwords_hu.txt
[junit4] 2> 2950461 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_el.txt to /configs/collection1.AUTOCREATED/lang/stopwords_el.txt
[junit4] 2> 2950464 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ru.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ru.txt
[junit4] 2> 2950467 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_tr.txt to /configs/collection1.AUTOCREATED/lang/stopwords_tr.txt
[junit4] 2> 2950471 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ar.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ar.txt
[junit4] 2> 2950474 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/userdict_ja.txt to /configs/collection1.AUTOCREATED/lang/userdict_ja.txt
[junit4] 2> 2950478 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_eu.txt to /configs/collection1.AUTOCREATED/lang/stopwords_eu.txt
[junit4] 2> 2950481 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_it.txt to /configs/collection1.AUTOCREATED/lang/stopwords_it.txt
[junit4] 2> 2950484 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_cz.txt to /configs/collection1.AUTOCREATED/lang/stopwords_cz.txt
[junit4] 2> 2950488 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stoptags_ja.txt to /configs/collection1.AUTOCREATED/lang/stoptags_ja.txt
[junit4] 2> 2950491 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_fr.txt to /configs/collection1.AUTOCREATED/lang/contractions_fr.txt
[junit4] 2> 2950494 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_de.txt to /configs/collection1.AUTOCREATED/lang/stopwords_de.txt
[junit4] 2> 2950497 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fa.txt to /configs/collection1.AUTOCREATED/lang/stopwords_fa.txt
[junit4] 2> 2950501 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/contractions_ga.txt to /configs/collection1.AUTOCREATED/lang/contractions_ga.txt
[junit4] 2> 2950504 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ca.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ca.txt
[junit4] 2> 2950508 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_nl.txt to /configs/collection1.AUTOCREATED/lang/stopwords_nl.txt
[junit4] 2> 2950511 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_bg.txt to /configs/collection1.AUTOCREATED/lang/stopwords_bg.txt
[junit4] 2> 2950514 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_en.txt to /configs/collection1.AUTOCREATED/lang/stopwords_en.txt
[junit4] 2> 2950517 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_es.txt to /configs/collection1.AUTOCREATED/lang/stopwords_es.txt
[junit4] 2> 2950524 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_lv.txt to /configs/collection1.AUTOCREATED/lang/stopwords_lv.txt
[junit4] 2> 2950527 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_ro.txt to /configs/collection1.AUTOCREATED/lang/stopwords_ro.txt
[junit4] 2> 2950530 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_th.txt to /configs/collection1.AUTOCREATED/lang/stopwords_th.txt
[junit4] 2> 2950533 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fr.txt to /configs/collection1.AUTOCREATED/lang/stopwords_fr.txt
[junit4] 2> 2950536 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_sv.txt to /configs/collection1.AUTOCREATED/lang/stopwords_sv.txt
[junit4] 2> 2950539 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_fi.txt to /configs/collection1.AUTOCREATED/lang/stopwords_fi.txt
[junit4] 2> 2950543 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/hyphenations_ga.txt to /configs/collection1.AUTOCREATED/lang/hyphenations_ga.txt
[junit4] 2> 2950546 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/lang/stopwords_gl.txt to /configs/collection1.AUTOCREATED/lang/stopwords_gl.txt
[junit4] 2> 2950550 INFO (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.c.ZkConfigManager Copying zk node /configs/_default/params.json to /configs/collection1.AUTOCREATED/params.json
[junit4] 2> 2950667 WARN (OverseerThreadFactory-15352-thread-1-processing-n:127.0.0.1:58992_solr) [n:127.0.0.1:58992_solr ] o.a.s.c.a.c.CreateCollectionCmd Specified number of replicas of 2 on collection collection1 is higher than the number of Solr instances currently live or live and part of your createNodeSet(1). It's unusual to run two replica of the same slice on the same Solr-instance.
[junit4] 2> 2950675 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:58992/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2950680 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n2",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:58992/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2950686 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n4",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:58992/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2950691 INFO (OverseerStateUpdate-72079206470123525-127.0.0.1:58992_solr-n_0000000000) [n:127.0.0.1:58992_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n6",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"http://127.0.0.1:58992/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 2950897 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr x:collection1_shard1_replica_n2 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node5&collection.configName=collection1.AUTOCREATED&newCollection=true&name=collection1_shard1_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2950897 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr x:collection1_shard1_replica_n1 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node3&collection.configName=collection1.AUTOCREATED&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2950897 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr x:collection1_shard2_replica_n6 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node8&collection.configName=collection1.AUTOCREATED&newCollection=true&name=collection1_shard2_replica_n6&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2950897 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr x:collection1_shard2_replica_n4 ] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&coreNodeName=core_node7&collection.configName=collection1.AUTOCREATED&newCollection=true&name=collection1_shard2_replica_n4&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 2950897 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr x:collection1_shard2_replica_n6 ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2951936 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 2951936 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/extraction/lib
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/clustering/lib
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/langid/lib
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../contrib/velocity/lib
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist
[junit4] 2> 2951937 WARN (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2/../../../../dist
[junit4] 2> 2951938 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 2951938 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 2951938 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2951938 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/extraction/lib
[junit4] 2> 2951938 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist
[junit4] 2> 2951938 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/clustering/lib
[junit4] 2> 2951938 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist
[junit4] 2> 2951938 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/langid/lib
[junit4] 2> 2951939 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist
[junit4] 2> 2951939 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../contrib/velocity/lib
[junit4] 2> 2951939 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist
[junit4] 2> 2951939 WARN (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6/../../../../dist
[junit4] 2> 2951939 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2951941 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 2951941 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/extraction/lib
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/clustering/lib
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/langid/lib
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../contrib/velocity/lib
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist
[junit4] 2> 2951942 WARN (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1/../../../../dist
[junit4] 2> 2951943 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2951949 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.RequestParams conf resource params.json loaded . version : 0
[junit4] 2> 2951949 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.RequestParams request params refreshed to version 0
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/extraction/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/extraction/lib
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist filtered by solr-cell-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/clustering/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/clustering/lib
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist filtered by solr-clustering-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/langid/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/langid/lib
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist filtered by solr-langid-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist
[junit4] 2> 2951950 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/velocity/lib filtered by .*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../contrib/velocity/lib
[junit4] 2> 2951951 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist filtered by solr-velocity-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist
[junit4] 2> 2951951 WARN (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Couldn't add files from /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist filtered by solr-ltr-\d.*\.jar to classpath: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4/../../../../dist
[junit4] 2> 2951951 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.4.0
[junit4] 2> 2951989 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=default-config
[junit4] 2> 2952017 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.IndexSchema [collection1_shard2_replica_n4] Schema name=default-config
[junit4] 2> 2952028 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.s.IndexSchema [collection1_shard2_replica_n6] Schema name=default-config
[junit4] 2> 2952053 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.s.IndexSchema [collection1_shard1_replica_n2] Schema name=default-config
[junit4] 2> 2952339 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 2952340 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 2952359 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 2952395 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.s.IndexSchema Loaded schema default-config/1.6 with uniqueid field id
[junit4] 2> 2952452 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n4' using configuration from collection collection1, trusted=true
[junit4] 2> 2952455 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using configuration from collection collection1, trusted=true
[junit4] 2> 2952455 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.core.collection1.shard2.replica_n4' (registry 'solr.core.collection1.shard2.replica_n4') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2952455 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.core.collection1.shard1.replica_n1' (registry 'solr.core.collection1.shard1.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2952456 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n1], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
[junit4] 2> 2952456 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n4] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n4], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/./collection1_shard2_replica_n4/data/]
[junit4] 2> 2952462 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 2952464 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 2952495 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n6' using configuration from collection collection1, trusted=true
[junit4] 2> 2952495 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.core.collection1.shard2.replica_n6' (registry 'solr.core.collection1.shard2.replica_n6') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2952495 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.c.SolrCore [[collection1_shard2_replica_n6] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard2_replica_n6], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/./collection1_shard2_replica_n6/data/]
[junit4] 2> 2952504 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 2952505 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n2' using configuration from collection collection1, trusted=true
[junit4] 2> 2952506 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.core.collection1.shard1.replica_n2' (registry 'solr.core.collection1.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@ec45ea8
[junit4] 2> 2952506 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.c.SolrCore [[collection1_shard1_replica_n2] ] Opening new SolrCore at [/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/collection1_shard1_replica_n2], dataDir=[/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-001/tempDir-001/node1/./collection1_shard1_replica_n2/data/]
[junit4] 2> 2952519 INFO (qtp1553300105-49204) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.r.XSLTResponseWriter xsltCacheLifetimeSeconds=5
[junit4] 2> 2952821 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2952821 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2952822 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2952822 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2952827 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 2952827 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2952828 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Hard AutoCommit: if uncommitted for 15000ms;
[junit4] 2> 2952828 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1 ] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2952840 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.SolrIndexSearcher Opening [Searcher@2f1eda29[collection1_shard2_replica_n4] main]
[junit4] 2> 2952843 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/collection1.AUTOCREATED
[junit4] 2> 2952843 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/collection1.AUTOCREATED
[junit4] 2> 2952843 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Creating ZooKeeper watch for the managed schema at /configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 2952844 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.ZkIndexSchemaReader Current schema version 0 is already the latest
[junit4] 2> 2952845 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.h.c.SpellCheckComponent Initializing spell checkers
[junit4] 2> 2952845 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.s.DirectSolrSpellChecker init: {name=default,field=_text_,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4] 2> 2952846 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2952846 INFO (qtp1553300105-49201) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1649332489479520256
[junit4] 2> 2952849 INFO (searcherExecutor-15357-thread-1-processing-n:127.0.0.1:58992_solr x:collection1_shard2_replica_n4 c:collection1 s:shard2 r:core_node7) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.QuerySenderListener QuerySenderListener sending requests to Searcher@2f1eda29[collection1_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2952849 INFO (searcherExecutor-15357-thread-1-processing-n:127.0.0.1:58992_solr x:collection1_shard2_replica_n4 c:collection1 s:shard2 r:core_node7) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.QuerySenderListener QuerySenderListener done.
[junit4] 2> 2952849 INFO (searcherExecutor-15357-thread-1-processing-n:127.0.0.1:58992_solr x:collection1_shard2_replica_n4 c:collection1 s:shard2 r:core_node7) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.h.c.SpellCheckComponent Loading spell index for spellchecker: default
[junit4] 2> 2952849 INFO (searcherExecutor-15357-thread-1-processing-n:127.0.0.1:58992_solr x:collection1_shard2_replica_n4 c:collection1 s:shard2 r:core_node7) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.c.SolrCore [collection1_shard2_replica_n4] Registered new searcher Searcher@2f1eda29[collection1_shard2_replica_n4] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2952851 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 2952851 INFO (qtp1553300105-49205) [n:127.0.0.1:58992_solr c:collection1 s:shard2 r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 2952853 INFO (qtp1553300105-49206) [n:127.0.0.1:58992_solr c:collection1 s:shard1 r:core_
[...truncated too long message...]
r:core_node8 x:collection1_shard2_replica_n6 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard2.leader, tag=SolrCore@5855c77d
[junit4] 2> 65910 INFO (coreCloseExecutor-104-thread-4) [n:127.0.0.1:57609_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard1.replica_n2, tag=SolrCore@7349fafc
[junit4] 2> 65910 INFO (coreCloseExecutor-104-thread-4) [n:127.0.0.1:57609_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@54efdd8b: rootName = solr_57609, domain = solr.core.collection1.shard1.replica_n2, service url = null, agent id = null] for registry solr.core.collection1.shard1.replica_n2 / com.codahale.metrics.MetricRegistry@4144b232
[junit4] 2> 65924 INFO (coreCloseExecutor-104-thread-4) [n:127.0.0.1:57609_solr c:collection1 s:shard1 r:core_node5 x:collection1_shard1_replica_n2 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard1.leader, tag=SolrCore@7349fafc
[junit4] 2> 65924 INFO (coreCloseExecutor-104-thread-3) [n:127.0.0.1:57609_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1.shard2.replica_n4, tag=SolrCore@42a65d8d
[junit4] 2> 65924 INFO (coreCloseExecutor-104-thread-3) [n:127.0.0.1:57609_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@69eedb57: rootName = solr_57609, domain = solr.core.collection1.shard2.replica_n4, service url = null, agent id = null] for registry solr.core.collection1.shard2.replica_n4 / com.codahale.metrics.MetricRegistry@35eee08f
[junit4] 2> 65935 INFO (coreCloseExecutor-104-thread-3) [n:127.0.0.1:57609_solr c:collection1 s:shard2 r:core_node7 x:collection1_shard2_replica_n4 ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.collection.collection1.shard2.leader, tag=SolrCore@42a65d8d
[junit4] 2> 65939 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 65939 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6c3cedde: rootName = solr_57609, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@4e3ed914
[junit4] 2> 65943 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 65943 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@6f7977af: rootName = solr_57609, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@fbf0cdf
[junit4] 2> 65946 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 65946 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@1d9de806: rootName = solr_57609, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@53ed0562
[junit4] 2> 65946 INFO (jetty-closer-107-thread-1) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster, tag=null
[junit4] 2> 65947 INFO (closeThreadPool-111-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72079411612614661-127.0.0.1:57609_solr-n_0000000000) closing
[junit4] 2> 65947 INFO (OverseerStateUpdate-72079411612614661-127.0.0.1:57609_solr-n_0000000000) [n:127.0.0.1:57609_solr ] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:57609_solr
[junit4] 2> 65947 INFO (OverseerAutoScalingTriggerThread-72079411612614661-127.0.0.1:57609_solr-n_0000000000) [ ] o.a.s.c.a.OverseerTriggerThread OverseerTriggerThread woken up but we are closed, exiting.
[junit4] 2> 65948 INFO (closeThreadPool-111-thread-2) [ ] o.a.s.c.Overseer Overseer (id=72079411612614661-127.0.0.1:57609_solr-n_0000000000) closing
[junit4] 2> 66061 INFO (jetty-closer-107-thread-1) [ ] o.a.s.c.Overseer Overseer (id=72079411612614661-127.0.0.1:57609_solr-n_0000000000) closing
[junit4] 2> 66063 INFO (jetty-closer-107-thread-1) [ ] o.e.j.s.AbstractConnector Stopped ServerConnector@22699868{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:0}
[junit4] 2> 66063 INFO (jetty-closer-107-thread-1) [ ] o.e.j.s.h.ContextHandler Stopped o.e.j.s.ServletContextHandler@67b7a344{/solr,null,UNAVAILABLE}
[junit4] 2> 66063 INFO (jetty-closer-107-thread-1) [ ] o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 66064 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 66283 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> 16 /solr/collections/recoveringFlag/terms/shard1
[junit4] 2> 11 /solr/collections/replicaCanBecomeLeader/terms/shard1
[junit4] 2> 11 /solr/collections/registerTerm/terms/shard1
[junit4] 2> 10 /solr/collections/raceConditionOnUpdates/terms/shard1
[junit4] 2> 10 /solr/collections/setTermEqualsToLeader/terms/shard1
[junit4] 2> 9 /solr/collections/coreTermWatcher/terms/shard1
[junit4] 2> 6 /solr/collections/collection1/terms/shard2
[junit4] 2> 4 /solr/configs/collection1.AUTOCREATED/managed-schema
[junit4] 2> 4 /solr/collections/collection1/terms/shard1
[junit4] 2> 4 /solr/collections/setTermToZero/terms/shard1
[junit4] 2> 2 /solr/clusterprops.json
[junit4] 2> 2 /solr/aliases.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 36 /solr/collections/collection1/state.json
[junit4] 2> 2 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 26 /solr/overseer/queue
[junit4] 2> 18 /solr/collections
[junit4] 2> 4 /solr/overseer/collection-queue-work
[junit4] 2> 3 /solr/live_nodes
[junit4] 2>
[junit4] 2> 68017 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer waitForServerDown: 127.0.0.1:57604
[junit4] 2> 68017 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:57604
[junit4] 2> 68017 INFO (SUITE-ZkShardTermsTest-seed#[60F3156584C18AA2]-worker) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 57604
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/solr/build/solr-core/test/J0/temp/solr.cloud.ZkShardTermsTest_60F3156584C18AA2-003
[junit4] 2> NOTE: test params are: codec=CheapBastard, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7a057885), locale=en-AT, timezone=America/Rainy_River
[junit4] 2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 13 (64-bit)/cpus=3,threads=1,free=77627632,total=192786432
[junit4] 2> NOTE: All tests run in this JVM: [ZkShardTermsTest, ZkShardTermsTest, ZkShardTermsTest]
[junit4] Completed [5/5 (5!)] on J0 in 18.28s, 10 tests, 1 failure <<< FAILURES!
[...truncated 14 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/lucene/common-build.xml:1590: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX/lucene/common-build.xml:1117: There were test failures: 5 suites, 50 tests, 5 failures [seed: 60F3156584C18AA2]
Total time: 1 minute 11 seconds
[repro] Setting last failure code to 256
[repro] Failures:
[repro] 5/5 failed: org.apache.solr.cloud.ZkShardTermsTest
[repro] Exiting with code 256
+ mv lucene/build lucene/build.repro
+ mv solr/build solr/build.repro
+ mv lucene/build.orig lucene/build
+ mv solr/build.orig solr/build
Archiving artifacts
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
[WARNINGS] Parsing warnings in console log with parser Java Compiler (javac)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
No credentials specified
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
<Git Blamer> Using GitBlamer to create author and commit information for all warnings.
<Git Blamer> GIT_COMMIT=a98198cc045dc55171df867e5541aaf292cc044b, workspace=/Users/jenkins/workspace/Lucene-Solr-8.x-MacOSX
[WARNINGS] Computing warning deltas based on reference build #401
Recording test results
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Build step 'Publish JUnit test result report' changed build result to UNSTABLE
Email was triggered for: Unstable (Test Failures)
Sending email for trigger: Unstable (Test Failures)
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2
Setting ANT_1_8_2_HOME=/Users/jenkins/tools/hudson.tasks.Ant_AntInstallation/ANT_1.8.2