You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2019/03/28 19:37:16 UTC
[JENKINS-EA] Lucene-Solr-8.x-Linux
(64bit/jdk-13-ea+shipilev-fastdebug) - Build # 317 - Still Unstable!
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/317/
Java: 64bit/jdk-13-ea+shipilev-fastdebug -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.cloud.DistribCursorPagingTest.test
Error Message:
nextCursorMark is null/missing
Stack Trace:
java.lang.AssertionError: nextCursorMark is null/missing
at __randomizedtesting.SeedInfo.seed([7AEB37F8AD10E7BB:F2BF082203EC8A43]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at org.junit.Assert.assertNotNull(Assert.java:712)
at org.apache.solr.cloud.DistribCursorPagingTest.assertHashNextCursorMark(DistribCursorPagingTest.java:687)
at org.apache.solr.cloud.DistribCursorPagingTest.assertFullWalkNoDups(DistribCursorPagingTest.java:722)
at org.apache.solr.cloud.DistribCursorPagingTest.doRandomSortsOnLargeIndex(DistribCursorPagingTest.java:596)
at org.apache.solr.cloud.DistribCursorPagingTest.test(DistribCursorPagingTest.java:94)
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 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:835)
Build Log:
[...truncated 13030 lines...]
[junit4] Suite: org.apache.solr.cloud.DistribCursorPagingTest
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/init-core-data-001
[junit4] 2> 427929 WARN (SUITE-DistribCursorPagingTest-seed#[7AEB37F8AD10E7BB]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=5 numCloses=5
[junit4] 2> 427929 INFO (SUITE-DistribCursorPagingTest-seed#[7AEB37F8AD10E7BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 427930 INFO (SUITE-DistribCursorPagingTest-seed#[7AEB37F8AD10E7BB]-worker) [ ] o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: @org.apache.solr.SolrTestCaseJ4$SuppressSSL(bugUrl="https://issues.apache.org/jira/browse/SOLR-9182 - causes OOM")
[junit4] 2> 427930 INFO (SUITE-DistribCursorPagingTest-seed#[7AEB37F8AD10E7BB]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 427931 INFO (SUITE-DistribCursorPagingTest-seed#[7AEB37F8AD10E7BB]-worker) [ ] o.a.s.BaseDistributedSearchTestCase Setting hostContext system property: /d_cyr/
[junit4] 2> 427938 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 427949 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 427949 INFO (ZkTestServer Run Thread) [ ] o.a.s.c.ZkTestServer Starting server
[junit4] 2> 428049 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer start zk server on port:42947
[junit4] 2> 428049 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42947
[junit4] 2> 428049 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42947
[junit4] 2> 428097 INFO (zkConnectionManagerCallback-2368-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428114 INFO (zkConnectionManagerCallback-2370-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428116 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig-deeppaging.xml to /configs/conf1/solrconfig.xml
[junit4] 2> 428117 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/schema-sorts.xml to /configs/conf1/schema.xml
[junit4] 2> 428118 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/solrconfig.snippet.randomindexconfig.xml to /configs/conf1/solrconfig.snippet.randomindexconfig.xml
[junit4] 2> 428118 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/stopwords.txt to /configs/conf1/stopwords.txt
[junit4] 2> 428119 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/protwords.txt to /configs/conf1/protwords.txt
[junit4] 2> 428120 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/currency.xml to /configs/conf1/currency.xml
[junit4] 2> 428121 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/enumsConfig.xml to /configs/conf1/enumsConfig.xml
[junit4] 2> 428122 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/open-exchange-rates.json to /configs/conf1/open-exchange-rates.json
[junit4] 2> 428122 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/mapping-ISOLatin1Accent.txt to /configs/conf1/mapping-ISOLatin1Accent.txt
[junit4] 2> 428123 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/old_synonyms.txt to /configs/conf1/old_synonyms.txt
[junit4] 2> 428124 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer put /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf/synonyms.txt to /configs/conf1/synonyms.txt
[junit4] 2> 428125 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Will use NRT replicas unless explicitly asked otherwise
[junit4] 2> 428443 WARN (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-testing+0-builds.shipilev.net-openjdk-jdk-b769-20190316-jdk-1312
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 428444 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 428445 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@69c959d3{/d_cyr,null,AVAILABLE}
[junit4] 2> 428464 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.AbstractConnector Started ServerConnector@61b93e3b{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:45321}
[junit4] 2> 428464 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.s.Server Started @428699ms
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/d_cyr, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/tempDir-001/control/data, hostPort=45321, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/control-001/cores}
[junit4] 2> 428465 ERROR (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 428465 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T17:46:47.327726Z
[junit4] 2> 428469 INFO (zkConnectionManagerCallback-2372-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428470 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 428470 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/control-001/solr.xml
[junit4] 2> 428474 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 428474 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 428475 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 428603 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 428606 WARN (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@565a4296[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 428629 WARN (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@5b3d1a21[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 428631 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42947/solr
[junit4] 2> 428646 INFO (zkConnectionManagerCallback-2379-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428660 INFO (zkConnectionManagerCallback-2381-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428731 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:45321_d_cyr
[junit4] 2> 428732 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.Overseer Overseer (id=72278436219191300-127.0.0.1:45321_d_cyr-n_0000000000) starting
[junit4] 2> 428737 INFO (zkConnectionManagerCallback-2388-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 428740 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 428741 INFO (OverseerStateUpdate-72278436219191300-127.0.0.1:45321_d_cyr-n_0000000000) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.Overseer Starting to work on the main queue : 127.0.0.1:45321_d_cyr
[junit4] 2> 428749 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:45321_d_cyr
[junit4] 2> 428757 INFO (zkCallback-2387-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 428765 INFO (zkCallback-2380-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 428840 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 428895 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 428929 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 428929 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 428931 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/control-001/cores
[junit4] 2> 429000 INFO (zkConnectionManagerCallback-2394-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 429002 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 429003 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 429011 INFO (qtp1182915310-5914) [n:127.0.0.1:45321_d_cyr ] 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:45321_d_cyr&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 429017 INFO (OverseerThreadFactory-1762-thread-1-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.a.c.CreateCollectionCmd Create collection control_collection
[junit4] 2> 429123 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 429123 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr x:control_collection_shard1_replica_n1] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 430162 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 430172 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema [control_collection_shard1_replica_n1] Schema name=sortable
[junit4] 2> 433560 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.IndexSchema Loaded schema sortable/1.6 with uniqueid field id
[junit4] 2> 433560 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433561 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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@30ffde0f
[junit4] 2> 433561 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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 [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/control-001/cores/control_collection_shard1_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/control-001/cores/control_collection_shard1_replica_n1/data/]
[junit4] 2> 433584 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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=1316166787, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 433759 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433759 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433763 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 433763 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 433766 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=53.5234375, floorSegmentMB=1.0498046875, forceMergeDeletesPctAllowed=15.052590992154425, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=41.6731532568772
[junit4] 2> 433766 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@59b0a729[control_collection_shard1_replica_n1] main]
[junit4] 2> 433767 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 433768 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433770 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 433770 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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 1629272368880812032
[junit4] 2> 433777 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433777 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433781 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 433781 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433781 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:45321/d_cyr/control_collection_shard1_replica_n1/
[junit4] 2> 433782 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433782 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr c:control_collection s:shard1 x:control_collection_shard1_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:45321/d_cyr/control_collection_shard1_replica_n1/ has no replicas
[junit4] 2> 433782 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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/72278436219191300-core_node2-n_0000000000
[junit4] 2> 433784 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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:45321/d_cyr/control_collection_shard1_replica_n1/ shard1
[junit4] 2> 433785 INFO (searcherExecutor-1767-thread-1-processing-n:127.0.0.1:45321_d_cyr x:control_collection_shard1_replica_n1 c:control_collection s:shard1) [n:127.0.0.1:45321_d_cyr 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@59b0a729[control_collection_shard1_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 433786 INFO (zkCallback-2380-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> 433787 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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> 433798 INFO (zkCallback-2380-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> 433819 INFO (qtp1182915310-5913) [n:127.0.0.1:45321_d_cyr 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=4696
[junit4] 2> 433825 INFO (qtp1182915310-5914) [n:127.0.0.1:45321_d_cyr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 433899 INFO (zkCallback-2380-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> 433899 INFO (zkCallback-2380-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> 433900 INFO (qtp1182915310-5914) [n:127.0.0.1:45321_d_cyr ] 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:45321_d_cyr&wt=javabin&version=2} status=0 QTime=4890
[junit4] 2> 433917 INFO (zkCallback-2380-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> 434057 INFO (zkConnectionManagerCallback-2400-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 434059 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 434060 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 434117 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ChaosMonkey monkey: init - expire sessions:false cause connection loss:false
[junit4] 2> 434129 INFO (qtp1182915310-5912) [n:127.0.0.1:45321_d_cyr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 434133 INFO (OverseerCollectionConfigSetProcessor-72278436219191300-127.0.0.1:45321_d_cyr-n_0000000000) [n:127.0.0.1:45321_d_cyr ] 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> 434133 INFO (OverseerThreadFactory-1762-thread-2-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
[junit4] 2> 434339 WARN (OverseerThreadFactory-1762-thread-2-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr ] o.a.s.c.a.c.CreateCollectionCmd It is unusual to create a collection (collection1) without cores.
[junit4] 2> 434342 INFO (qtp1182915310-5912) [n:127.0.0.1:45321_d_cyr ] o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 45 seconds. Check all shard replicas
[junit4] 2> 434342 INFO (qtp1182915310-5912) [n:127.0.0.1:45321_d_cyr ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={collection.configName=conf1&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&createNodeSet=&stateFormat=2&wt=javabin&version=2} status=0 QTime=213
[junit4] 2> 434375 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase Creating jetty instances pullReplicaCount=0 numOtherReplicas=4
[junit4] 2> 435024 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 1 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001 of type NRT
[junit4] 2> 435135 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 435135 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 435135 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 435135 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-testing+0-builds.shipilev.net-openjdk-jdk-b769-20190316-jdk-1312
[junit4] 2> 435157 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 435157 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 435157 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 435165 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@5907ece1{/d_cyr,null,AVAILABLE}
[junit4] 2> 435173 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@1527f679{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:43471}
[junit4] 2> 435173 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.Server Started @435408ms
[junit4] 2> 435173 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/d_cyr, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/tempDir-001/jetty1, hostPort=43471, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001/cores, replicaType=NRT}
[junit4] 2> 435174 ERROR (closeThreadPool-2401-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 435174 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 435174 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0
[junit4] 2> 435174 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 435174 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 435174 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T17:46:54.036780Z
[junit4] 2> 435207 INFO (zkConnectionManagerCallback-2403-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 435214 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 435214 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001/solr.xml
[junit4] 2> 435219 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 435219 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 435220 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 435296 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 435322 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@158b096b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 435365 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@50ab7902[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 435366 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42947/solr
[junit4] 2> 435580 INFO (zkConnectionManagerCallback-2410-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 435602 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 2 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001 of type NRT
[junit4] 2> 435605 INFO (zkConnectionManagerCallback-2412-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 435610 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 435615 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.ZkController Publish node=127.0.0.1:43471_d_cyr as DOWN
[junit4] 2> 435616 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 435616 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:43471_d_cyr
[junit4] 2> 435617 INFO (zkCallback-2380-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 435617 INFO (zkCallback-2387-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 435625 WARN (closeThreadPool-2401-thread-2) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 435626 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 435626 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 435626 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-testing+0-builds.shipilev.net-openjdk-jdk-b769-20190316-jdk-1312
[junit4] 2> 435641 INFO (zkCallback-2411-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 435649 INFO (zkCallback-2399-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 435717 INFO (zkConnectionManagerCallback-2419-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 435718 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 435719 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 435750 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 435750 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 435750 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.session node0 Scavenging every 660000ms
[junit4] 2> 435761 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 435777 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@1b5bf600{/d_cyr,null,AVAILABLE}
[junit4] 2> 435777 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.AbstractConnector Started ServerConnector@40e24799{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41307}
[junit4] 2> 435777 INFO (closeThreadPool-2401-thread-2) [ ] o.e.j.s.Server Started @436012ms
[junit4] 2> 435777 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/d_cyr, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/tempDir-001/jetty2, hostPort=41307, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001/cores, replicaType=NRT}
[junit4] 2> 435778 ERROR (closeThreadPool-2401-thread-2) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 435778 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 435781 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0
[junit4] 2> 435781 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 435781 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 435781 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T17:46:54.643746Z
[junit4] 2> 435814 INFO (zkConnectionManagerCallback-2422-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 435815 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 435815 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001/solr.xml
[junit4] 2> 435819 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 435819 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 435821 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 435833 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 435854 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 3 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-3-001 of type NRT
[junit4] 2> 435875 WARN (closeThreadPool-2401-thread-3) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 435875 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 435875 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 435876 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-testing+0-builds.shipilev.net-openjdk-jdk-b769-20190316-jdk-1312
[junit4] 2> 435888 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 435894 WARN (closeThreadPool-2401-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@84fa3e3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 435904 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 435905 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 436058 INFO (closeThreadPool-2401-thread-1) [n:127.0.0.1:43471_d_cyr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001/cores
[junit4] 2> 436121 WARN (closeThreadPool-2401-thread-2) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7303e86[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 436123 INFO (closeThreadPool-2401-thread-2) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42947/solr
[junit4] 2> 436134 INFO (OverseerCollectionConfigSetProcessor-72278436219191300-127.0.0.1:45321_d_cyr-n_0000000000) [n:127.0.0.1:45321_d_cyr ] 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> 436173 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 436173 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 436173 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 436178 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@67ac8531{/d_cyr,null,AVAILABLE}
[junit4] 2> 436179 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.AbstractConnector Started ServerConnector@3d5c6523{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:41637}
[junit4] 2> 436179 INFO (closeThreadPool-2401-thread-3) [ ] o.e.j.s.Server Started @436414ms
[junit4] 2> 436179 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/d_cyr, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/tempDir-001/jetty3, hostPort=41637, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-3-001/cores, replicaType=NRT}
[junit4] 2> 436225 ERROR (closeThreadPool-2401-thread-3) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 436225 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 436226 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0
[junit4] 2> 436226 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 436226 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 436226 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T17:46:55.088318Z
[junit4] 2> 436237 INFO (zkConnectionManagerCallback-2429-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436288 INFO (zkConnectionManagerCallback-2431-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436333 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 436333 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-3-001/solr.xml
[junit4] 2> 436338 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 436338 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 436340 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 436343 INFO (zkConnectionManagerCallback-2433-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436346 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
[junit4] 2> 436348 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.ZkController Publish node=127.0.0.1:41307_d_cyr as DOWN
[junit4] 2> 436349 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 436349 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41307_d_cyr
[junit4] 2> 436350 INFO (zkCallback-2387-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436350 INFO (zkCallback-2411-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436350 INFO (zkCallback-2380-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436350 INFO (zkCallback-2399-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436360 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436375 INFO (zkCallback-2418-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 436397 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.AbstractFullDistribZkTestBase create jetty 4 in directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-4-001 of type NRT
[junit4] 2> 436397 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 436398 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 436398 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 436398 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git: c4550056e785fb5665914545889f21dc136ad9e6; jvm 13-testing+0-builds.shipilev.net-openjdk-jdk-b769-20190316-jdk-1312
[junit4] 2> 436441 INFO (zkConnectionManagerCallback-2441-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436442 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 436443 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 436503 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 436533 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 436533 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 436533 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 436543 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.h.ContextHandler Started o.e.j.s.ServletContextHandler@edabb32{/d_cyr,null,AVAILABLE}
[junit4] 2> 436543 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.AbstractConnector Started ServerConnector@5334775{HTTP/1.1,[http/1.1, h2c]}{127.0.0.1:46583}
[junit4] 2> 436543 INFO (closeThreadPool-2401-thread-1) [ ] o.e.j.s.Server Started @436778ms
[junit4] 2> 436543 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/d_cyr, solrconfig=solrconfig.xml, solr.data.dir=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/tempDir-001/jetty4, hostPort=46583, coreRootDirectory=/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-4-001/cores}
[junit4] 2> 436544 ERROR (closeThreadPool-2401-thread-1) [ ] o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be missing or incomplete.
[junit4] 2> 436544 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter Using logger factory org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 436544 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version 8.1.0
[junit4] 2> 436544 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 436544 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 436544 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time: 2019-03-28T17:46:55.406453Z
[junit4] 2> 436570 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 436587 INFO (zkConnectionManagerCallback-2444-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436588 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.s.SolrDispatchFilter Loading solr.xml from SolrHome (not found in ZooKeeper)
[junit4] 2> 436588 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Loading container configuration from /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-4-001/solr.xml
[junit4] 2> 436593 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverWorkLoopDelay is ignored
[junit4] 2> 436593 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig Configuration parameter autoReplicaFailoverBadNodeExpiration is ignored
[junit4] 2> 436594 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.SolrXmlConfig MBean server found: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f, but no JMX reporters were configured - adding default JMX reporter.
[junit4] 2> 436622 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 436628 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 436628 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 436641 INFO (closeThreadPool-2401-thread-2) [n:127.0.0.1:41307_d_cyr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001/cores
[junit4] 2> 436650 WARN (closeThreadPool-2401-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@289d7412[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 436710 WARN (closeThreadPool-2401-thread-3) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3c49d66b[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 436711 INFO (closeThreadPool-2401-thread-3) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42947/solr
[junit4] 2> 436869 INFO (zkConnectionManagerCallback-2451-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436910 INFO (zkConnectionManagerCallback-2453-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 436913 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (3)
[junit4] 2> 436915 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.ZkController Publish node=127.0.0.1:41637_d_cyr as DOWN
[junit4] 2> 436915 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 436915 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:41637_d_cyr
[junit4] 2> 436917 INFO (zkCallback-2411-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436917 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436917 INFO (zkCallback-2399-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436917 INFO (zkCallback-2380-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436917 INFO (zkCallback-2418-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436917 INFO (zkCallback-2387-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436929 INFO (zkCallback-2440-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 436943 INFO (zkCallback-2452-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 437023 INFO (zkConnectionManagerCallback-2460-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 437025 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 437026 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 437061 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 437123 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437178 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437178 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437181 INFO (closeThreadPool-2401-thread-3) [n:127.0.0.1:41637_d_cyr ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-3-001/cores
[junit4] 2> 437203 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=false]
[junit4] 2> 437226 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7eb14e43[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 437261 WARN (closeThreadPool-2401-thread-1) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@29938cfc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 437262 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:42947/solr
[junit4] 2> 437301 INFO (zkConnectionManagerCallback-2467-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 437325 INFO (zkConnectionManagerCallback-2469-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 437330 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 437332 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.ZkController Publish node=127.0.0.1:46583_d_cyr as DOWN
[junit4] 2> 437332 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 4 transient cores
[junit4] 2> 437332 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.ZkController Register node as live in ZooKeeper:/live_nodes/127.0.0.1:46583_d_cyr
[junit4] 2> 437333 INFO (zkCallback-2411-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437333 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437333 INFO (zkCallback-2440-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437333 INFO (zkCallback-2418-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437334 INFO (zkCallback-2387-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437334 INFO (zkCallback-2399-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437334 INFO (zkCallback-2452-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437334 INFO (zkCallback-2380-thread-3) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437349 INFO (zkCallback-2459-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437353 INFO (zkCallback-2468-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (5)
[junit4] 2> 437369 INFO (zkConnectionManagerCallback-2476-thread-1) [ ] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 437370 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (5)
[junit4] 2> 437371 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:42947/solr ready
[junit4] 2> 437373 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 437406 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437439 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437440 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 437442 INFO (closeThreadPool-2401-thread-1) [ ] o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-4-001/cores
[junit4] 2> 437717 INFO (qtp2004499367-6106) [n:127.0.0.1:41307_d_cyr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:43471_d_cyr&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 437718 INFO (qtp2004499367-5999) [n:127.0.0.1:41307_d_cyr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:41307_d_cyr&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 437727 INFO (qtp2004499367-6107) [n:127.0.0.1:41307_d_cyr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:46583_d_cyr&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 437730 INFO (qtp2004499367-6001) [n:127.0.0.1:41307_d_cyr ] o.a.s.h.a.CollectionsHandler Invoked Collection Action :addreplica with params node=127.0.0.1:41637_d_cyr&action=ADDREPLICA&collection=collection1&shard=shard2&type=NRT&wt=javabin&version=2 and sendToOCPQueue=true
[junit4] 2> 437731 INFO (OverseerThreadFactory-1762-thread-3-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:43471_d_cyr for creating new replica of shard shard2 for collection collection1
[junit4] 2> 437732 INFO (OverseerThreadFactory-1762-thread-3-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr c:collection1 s:shard2 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 437734 INFO (OverseerThreadFactory-1762-thread-4-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Node Identified 127.0.0.1:41307_d_cyr for creating new replica of shard shard1 for collection collection1
[junit4] 2> 437735 INFO (OverseerThreadFactory-1762-thread-4-processing-n:127.0.0.1:45321_d_cyr) [n:127.0.0.1:45321_d_cyr c:collection1 s:shard1 ] o.a.s.c.a.c.AddReplicaCmd Returning CreateReplica command.
[junit4] 2> 437754 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr x:collection1_shard2_replica_n1] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard2_replica_n1&action=CREATE&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 437756 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr x:collection1_shard1_replica_n2] o.a.s.h.a.CoreAdminOperation core create command qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n2&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 438802 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 438805 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 438945 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.s.IndexSchema [collection1_shard2_replica_n1] Schema name=sortable
[junit4] 2> 438951 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.s.IndexSchema [collection1_shard1_replica_n2] Schema name=sortable
[junit4] 2> 439296 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.s.IndexSchema Loaded schema sortable/1.6 with uniqueid field id
[junit4] 2> 439296 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 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> 439297 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard1.replica_n2' (registry 'solr.core.collection1.shard1.replica_n2') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 439297 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SolrCore [[collection1_shard1_replica_n2] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001/cores/collection1_shard1_replica_n2], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-2-001/cores/collection1_shard1_replica_n2/data/]
[junit4] 2> 439307 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1316166787, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 439396 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.s.IndexSchema Loaded schema sortable/1.6 with uniqueid field id
[junit4] 2> 439396 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n1' using configuration from collection collection1, trusted=true
[junit4] 2> 439397 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1.shard2.replica_n1' (registry 'solr.core.collection1.shard2.replica_n1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@30ffde0f
[junit4] 2> 439406 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SolrCore [[collection1_shard2_replica_n1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001/cores/collection1_shard2_replica_n1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/../../../../../../../../../home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001/shard-1-001/cores/collection1_shard2_replica_n1/data/]
[junit4] 2> 439417 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.AlcoholicMergePolicy: [AlcoholicMergePolicy: minMergeSize=0, mergeFactor=10, maxMergeSize=1316166787, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=true, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.1]
[junit4] 2> 439470 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 439471 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 439478 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 439479 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 439488 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=53.5234375, floorSegmentMB=1.0498046875, forceMergeDeletesPctAllowed=15.052590992154425, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=41.6731532568772
[junit4] 2> 439489 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.s.SolrIndexSearcher Opening [Searcher@45816763[collection1_shard1_replica_n2] main]
[junit4] 2> 439492 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 439492 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 439493 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 439493 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629272374881812480
[junit4] 2> 439500 INFO (searcherExecutor-1808-thread-1-processing-n:127.0.0.1:41307_d_cyr x:collection1_shard1_replica_n2 c:collection1 s:shard1) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SolrCore [collection1_shard1_replica_n2] Registered new searcher Searcher@45816763[collection1_shard1_replica_n2] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 439515 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard1 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 439515 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard1
[junit4] 2> 439517 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 439517 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 439517 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:41307/d_cyr/collection1_shard1_replica_n2/
[junit4] 2> 439517 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 439517 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.SyncStrategy http://127.0.0.1:41307/d_cyr/collection1_shard1_replica_n2/ has no replicas
[junit4] 2> 439518 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard1/leader after winning as /collections/collection1/leader_elect/shard1/election/72278436219191311-core_node4-n_0000000000
[junit4] 2> 439519 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:41307/d_cyr/collection1_shard1_replica_n2/ shard1
[junit4] 2> 439529 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.UpdateHandler Using UpdateLog implementation: org.apache.solr.update.UpdateLog
[junit4] 2> 439529 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 439744 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 439744 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 439746 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
[junit4] 2> 439747 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 439754 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.RandomMergePolicy RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=19, maxMergeAtOnceExplicit=40, maxMergedSegmentMB=53.5234375, floorSegmentMB=1.0498046875, forceMergeDeletesPctAllowed=15.052590992154425, segmentsPerTier=21.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=1.0, deletesPctAllowed=41.6731532568772
[junit4] 2> 439755 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.s.SolrIndexSearcher Opening [Searcher@31801503[collection1_shard2_replica_n1] main]
[junit4] 2> 439757 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: /configs/conf1
[junit4] 2> 439757 INFO (zkCallback-2432-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
[junit4] 2> 439757 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using ZooKeeperStorageIO:path=/configs/conf1
[junit4] 2> 439758 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 439758 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.u.UpdateLog Could not find max version in index or recent updates, using new clock 1629272375159685120
[junit4] 2> 439775 INFO (searcherExecutor-1809-thread-1-processing-n:127.0.0.1:43471_d_cyr x:collection1_shard2_replica_n1 c:collection1 s:shard2) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SolrCore [collection1_shard2_replica_n1] Registered new searcher Searcher@31801503[collection1_shard2_replica_n1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 439778 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ZkShardTerms Successful update of terms at /collections/collection1/terms/shard2 to Terms{values={core_node3=0}, version=0}
[junit4] 2> 439778 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ShardLeaderElectionContextBase make sure parent is created /collections/collection1/leaders/shard2
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SyncStrategy Sync replicas to http://127.0.0.1:43471/d_cyr/collection1_shard2_replica_n1/
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.SyncStrategy http://127.0.0.1:43471/d_cyr/collection1_shard2_replica_n1/ has no replicas
[junit4] 2> 439781 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node /collections/collection1/leaders/shard2/leader after winning as /collections/collection1/leader_elect/shard2/election/72278436219191306-core_node3-n_0000000000
[junit4] 2> 439782 INFO (qtp962286367-5974) [n:127.0.0.1:43471_d_cyr c:collection1 s:shard2 x:collection1_shard2_replica_n1] o.a.s.c.ShardLeaderElectionContext I am the new leader: http://127.0.0.1:43471/d_cyr/collection1_shard2_replica_n1/ shard2
[junit4] 2> 439798 INFO (qtp2004499367-6003) [n:127.0.0.1:41307_d_cyr c:collection1 s:shard1 x:collection1_shard1_replica_n2] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores params={qt=/admin/cores&collection.configName=conf1&name=collection1_shard1_replica_n2&action=CREATE&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT} status=0 QTime=2043
[junit4] 2> 439801 INFO (qtp2004499367-5999) [n:127.0.0.1:41307_d_cyr c:collection1 ] o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections params={node=127.0.0.1:41307_d_cyr&action=ADDREPLICA&collection=collection1&shard=shard1&type=NRT&wt=javabin&version=2} status=0 QTime=2083
[junit4] 2> 439884 INFO (zkCallback-2432-thread-2) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
[junit4] 2> 439884 INFO (zkCallback-2432-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [5])
[junit4] 2> 439884 INFO (zkCallback-2411-thread-1) [ ] o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent state:SyncConnected type:NodeDataChanged path:/collections/collection1/state.json] for collection [collection1] has occurred - updating... (live nodes size: [
[...truncated too long message...]
r Shutting down ZkTestServer.
[junit4] 2> 500817 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> 12 /solr/aliases.json
[junit4] 2> 7 /solr/collections/collection1/terms/shard1
[junit4] 2> 7 /solr/collections/collection1/terms/shard2
[junit4] 2> 5 /solr/security.json
[junit4] 2> 5 /solr/configs/conf1
[junit4] 2> 3 /solr/collections/control_collection/terms/shard1
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 66 /solr/collections/collection1/state.json
[junit4] 2> 12 /solr/clusterstate.json
[junit4] 2> 12 /solr/clusterprops.json
[junit4] 2> 9 /solr/collections/control_collection/state.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 12 /solr/live_nodes
[junit4] 2> 12 /solr/collections
[junit4] 2>
[junit4] 2> 500824 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:42947
[junit4] 2> 500824 INFO (TEST-DistribCursorPagingTest.test-seed#[7AEB37F8AD10E7BB]) [ ] o.a.s.c.ZkTestServer connecting to 127.0.0.1 42947
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=DistribCursorPagingTest -Dtests.method=test -Dtests.seed=7AEB37F8AD10E7BB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ka-GE -Dtests.timezone=Africa/Lome -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[junit4] FAILURE 72.9s J0 | DistribCursorPagingTest.test <<<
[junit4] > Throwable #1: java.lang.AssertionError: nextCursorMark is null/missing
[junit4] > at __randomizedtesting.SeedInfo.seed([7AEB37F8AD10E7BB:F2BF082203EC8A43]:0)
[junit4] > at org.apache.solr.cloud.DistribCursorPagingTest.assertHashNextCursorMark(DistribCursorPagingTest.java:687)
[junit4] > at org.apache.solr.cloud.DistribCursorPagingTest.assertFullWalkNoDups(DistribCursorPagingTest.java:722)
[junit4] > at org.apache.solr.cloud.DistribCursorPagingTest.doRandomSortsOnLargeIndex(DistribCursorPagingTest.java:596)
[junit4] > at org.apache.solr.cloud.DistribCursorPagingTest.test(DistribCursorPagingTest.java:94)
[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:567)
[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:835)
[junit4] 2> NOTE: leaving temporary files on disk at: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.cloud.DistribCursorPagingTest_7AEB37F8AD10E7BB-001
[junit4] 2> Mar 28, 2019 5:47:59 PM com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked thread(s).
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene80): {date=PostingsFormat(name=LuceneVarGapDocFreqInterval), bool=PostingsFormat(name=LuceneVarGapDocFreqInterval), collation_en_primary_first=PostingsFormat(name=LuceneFixedGap), currency_first____amount_raw=PostingsFormat(name=LuceneFixedGap), str_last=FST50, currency_first____currency=PostingsFormat(name=LuceneFixedGap), double_last=PostingsFormat(name=LuceneVarGapDocFreqInterval), float=FST50, uuid=PostingsFormat(name=LuceneFixedGap), int_last=PostingsFormat(name=LuceneVarGapDocFreqInterval), long=FST50, enum_first=FST50, double_first=PostingsFormat(name=LuceneVarGapDocFreqInterval), str_first=FST50, icu_collation_en_primary_first=PostingsFormat(name=LuceneFixedGap), float_first=FSTOrd50, id=PostingsFormat(name=LuceneFixedGap), currency____amount_raw=FST50, long_first=FSTOrd50, collation_en_primary_last=PostingsFormat(name=LuceneFixedGap), currency_last____currency=FSTOrd50, date_last=PostingsFormat(name=LuceneFixedGap), uuid_first=FST50, bool_first=PostingsFormat(name=LuceneFixedGap), double=FSTOrd50, long_last=FSTOrd50, _root_=FST50, bool_last=PostingsFormat(name=LuceneFixedGap), uuid_last=FST50, int=PostingsFormat(name=LuceneFixedGap), enum=FSTOrd50, int_first=FST50, str=FSTOrd50, enum_dv_last=FSTOrd50, enum_last=FST50, _version_=FST50, icu_collation_en_primary_last=PostingsFormat(name=LuceneFixedGap), currency____currency=FST50, currency_last____amount_raw=FSTOrd50, enum_dv_first=FSTOrd50, date_first=PostingsFormat(name=LuceneFixedGap), float_last=FSTOrd50, enum_dv=PostingsFormat(name=LuceneVarGapDocFreqInterval)}, docValues:{date=DocValuesFormat(name=Lucene80), collation_en_primary_dv_first=DocValuesFormat(name=Lucene80), collation_en_primary_dv=DocValuesFormat(name=Direct), bin=DocValuesFormat(name=Direct), date_dv_last=DocValuesFormat(name=Lucene80), float=DocValuesFormat(name=Lucene80), bin_last=DocValuesFormat(name=Lucene80), int_dv=DocValuesFormat(name=Lucene80), str_dv_first=DocValuesFormat(name=Asserting), icu_collation_en_primary_dv=DocValuesFormat(name=Direct), float_dv=DocValuesFormat(name=Asserting), long_dv_last=DocValuesFormat(name=Lucene80), bin_first=DocValuesFormat(name=Lucene80), collation_en_primary_dv_last=DocValuesFormat(name=Lucene80), date_last=DocValuesFormat(name=Direct), long_dv_first=DocValuesFormat(name=Lucene80), double=DocValuesFormat(name=Asserting), float_dv_last=DocValuesFormat(name=Lucene80), bin_dv_last=DocValuesFormat(name=Direct), uuid_dv_first=DocValuesFormat(name=Direct), double_dv=DocValuesFormat(name=Lucene80), enum_dv_last=DocValuesFormat(name=Asserting), str_dv=DocValuesFormat(name=Lucene80), date_first=DocValuesFormat(name=Direct), bin_dv_first=DocValuesFormat(name=Direct), enum_dv=DocValuesFormat(name=Lucene80), uuid_dv=DocValuesFormat(name=Lucene80), icu_collation_en_primary_dv_first=DocValuesFormat(name=Lucene80), date_dv=DocValuesFormat(name=Direct), float_dv_first=DocValuesFormat(name=Lucene80), double_dv_last=DocValuesFormat(name=Asserting), uuid_dv_last=DocValuesFormat(name=Direct), date_dv_first=DocValuesFormat(name=Lucene80), double_last=DocValuesFormat(name=Lucene80), int_last=DocValuesFormat(name=Lucene80), long=DocValuesFormat(name=Lucene80), str_dv_last=DocValuesFormat(name=Asserting), double_first=DocValuesFormat(name=Lucene80), icu_collation_en_primary_dv_last=DocValuesFormat(name=Lucene80), float_first=DocValuesFormat(name=Asserting), long_first=DocValuesFormat(name=Asserting), int_dv_first=DocValuesFormat(name=Direct), long_last=DocValuesFormat(name=Asserting), double_dv_first=DocValuesFormat(name=Asserting), int=DocValuesFormat(name=Direct), int_first=DocValuesFormat(name=Lucene80), int_dv_last=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Lucene80), enum_dv_first=DocValuesFormat(name=Asserting), float_last=DocValuesFormat(name=Asserting), long_dv=DocValuesFormat(name=Asserting), bin_dv=DocValuesFormat(name=Lucene80)}, maxPointsInLeafNode=1492, maxMBSortInHeap=7.11957339411185, sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@6b5175b), locale=ka-GE, timezone=Africa/Lome
[junit4] 2> NOTE: Linux 4.18.0-15-generic amd64/Aleksey Shipilev 13-testing (64-bit)/cpus=8,threads=1,free=127657288,total=518979584
[junit4] 2> NOTE: All tests run in this JVM: [TriggerCooldownIntegrationTest, TestManagedSynonymFilterFactory, TestDownShardTolerantSearch, TestCrossCoreJoin, DeleteReplicaTest, TestObjectReleaseTracker, SortSpecParsingTest, SolrMetricManagerTest, PeerSyncWithIndexFingerprintCachingTest, ZkNodePropsTest, OutOfBoxZkACLAndCredentialsProvidersTest, DeleteInactiveReplicaTest, TestNRTOpen, TimeRoutedAliasUpdateProcessorTest, FieldAnalysisRequestHandlerTest, SolrGangliaReporterTest, AutoScalingHandlerTest, TestHttpShardHandlerFactory, RootFieldTest, HdfsSyncSliceTest, ConnectionManagerTest, SearchRateTriggerTest, TestManagedSchemaAPI, TestRawResponseWriter, PolyFieldTest, CdcrBootstrapTest, RangeFacetCloudTest, TestConfig, TestMiniSolrCloudClusterSSL, IndexSchemaRuntimeFieldTest, TestDefaultStatsCache, TestReloadAndDeleteDocs, PingRequestHandlerTest, DistribCursorPagingTest]
[junit4] Completed [86/845 (1!)] on J0 in 74.04s, 1 test, 1 failure <<< FAILURES!
[...truncated 45244 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/317/consoleText
[repro] Revision: 543ea46afad1f52de82b9b820fba0fe7458bae42
[repro] Ant options: "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC"
[repro] Repro line: ant test -Dtestcase=DistribCursorPagingTest -Dtests.method=test -Dtests.seed=7AEB37F8AD10E7BB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ka-GE -Dtests.timezone=Africa/Lome -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] DistribCursorPagingTest
[repro] ant compile-test
[...truncated 3581 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.DistribCursorPagingTest" -Dtests.showOutput=onerror "-Dargs=-XX:+UseCompressedOops -XX:+UseSerialGC" -Dtests.seed=7AEB37F8AD10E7BB -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ka-GE -Dtests.timezone=Africa/Lome -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 83 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.cloud.DistribCursorPagingTest
[repro] Exiting with code 0
[...truncated 43 lines...]
[JENKINS] Lucene-Solr-8.x-Linux (64bit/jdk-11) - Build # 318 -
Still Unstable!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/318/
Java: 64bit/jdk-11 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
FAILED: org.apache.solr.index.UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues
Error Message:
expected:<[7]> but was:<[98]>
Stack Trace:
org.junit.ComparisonFailure: expected:<[7]> but was:<[98]>
at __randomizedtesting.SeedInfo.seed([FD07CB6CB0AFCB8D:A8E04DAFF9488B79]:0)
at org.junit.Assert.assertEquals(Assert.java:115)
at org.junit.Assert.assertEquals(Assert.java:144)
at org.apache.solr.index.UninvertDocValuesMergePolicyTest.lambda$testIndexAndAddDocValues$2(UninvertDocValuesMergePolicyTest.java:143)
at org.apache.solr.index.UninvertDocValuesMergePolicyTest.withNewRawReader(UninvertDocValuesMergePolicyTest.java:233)
at org.apache.solr.index.UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues(UninvertDocValuesMergePolicyTest.java:118)
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 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 2078 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/core/test/temp/junit4-J2-20190329_004427_7764494289275997799159.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/core/test/temp/junit4-J0-20190329_004427_77617573967282729666430.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 5 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/core/test/temp/junit4-J1-20190329_004427_7777050999236833756284.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 304 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/test-framework/test/temp/junit4-J2-20190329_005835_5069685506332050331802.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/test-framework/test/temp/junit4-J1-20190329_005835_50614515991977632356451.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/test-framework/test/temp/junit4-J0-20190329_005835_5063126285368263738137.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 1080 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/common/test/temp/junit4-J0-20190329_010047_1569231619473986020716.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/common/test/temp/junit4-J2-20190329_010047_1563550982242229839547.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/common/test/temp/junit4-J1-20190329_010047_1605160559791705612910.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 255 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/icu/test/temp/junit4-J2-20190329_010314_66212077721489043964555.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/icu/test/temp/junit4-J0-20190329_010314_65914335470072050977300.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/icu/test/temp/junit4-J1-20190329_010314_6611749970460945427708.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 253 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/kuromoji/test/temp/junit4-J0-20190329_010330_06712128820925974037725.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/kuromoji/test/temp/junit4-J1-20190329_010330_0712096971584278007100.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/kuromoji/test/temp/junit4-J2-20190329_010330_06714086697973144449092.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 162 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/morfologik/test/temp/junit4-J1-20190329_010401_047198474558115652991.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/morfologik/test/temp/junit4-J0-20190329_010401_0471799718366033166920.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/morfologik/test/temp/junit4-J2-20190329_010401_0573319348818812618929.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 207 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/nori/test/temp/junit4-J0-20190329_010406_5093642851960459659182.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/nori/test/temp/junit4-J2-20190329_010406_5112778971548894887223.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/nori/test/temp/junit4-J1-20190329_010406_51117670221303462489289.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 168 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/opennlp/test/temp/junit4-J2-20190329_010419_43017365207903276522077.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/opennlp/test/temp/junit4-J0-20190329_010419_43014450153599292160565.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/opennlp/test/temp/junit4-J1-20190329_010419_4309019801280749281566.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 176 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/phonetic/test/temp/junit4-J0-20190329_010423_539756540179538459074.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/phonetic/test/temp/junit4-J1-20190329_010423_545949993830384271255.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/phonetic/test/temp/junit4-J2-20190329_010423_5486060258653039532027.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 161 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/smartcn/test/temp/junit4-J0-20190329_010438_91513059532292478561047.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/smartcn/test/temp/junit4-J1-20190329_010438_92117630606782683684584.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 165 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/stempel/test/temp/junit4-J0-20190329_010450_0862662095193622441178.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/stempel/test/temp/junit4-J1-20190329_010450_0868878539446646692050.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/analysis/stempel/test/temp/junit4-J2-20190329_010450_08614114142225260797508.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 177 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/backward-codecs/test/temp/junit4-J2-20190329_010454_58216595124681886301029.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 19 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/backward-codecs/test/temp/junit4-J0-20190329_010454_58215445294401688673954.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 9 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/backward-codecs/test/temp/junit4-J1-20190329_010454_58213501082054959350203.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 1545 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/benchmark/test/temp/junit4-J1-20190329_010855_656666973453246165483.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/benchmark/test/temp/junit4-J2-20190329_010855_6597013275740152103333.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/benchmark/test/temp/junit4-J0-20190329_010855_65613505603006097752609.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 250 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/classification/test/temp/junit4-J2-20190329_010909_40911473458539388365421.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/classification/test/temp/junit4-J0-20190329_010909_3991932868177043646396.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/classification/test/temp/junit4-J1-20190329_010909_40918139655241523403992.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 258 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/codecs/test/temp/junit4-J2-20190329_010924_61812161803559128333446.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/codecs/test/temp/junit4-J1-20190329_010924_6184493840894357041588.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 4 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/codecs/test/temp/junit4-J0-20190329_010924_61815697332162762496490.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 230 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/demo/test/temp/junit4-J0-20190329_011439_71518236038740874516042.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 6 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/demo/test/temp/junit4-J2-20190329_011439_7364945582608134258506.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/demo/test/temp/junit4-J1-20190329_011439_7362815891544524271884.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 176 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/expressions/test/temp/junit4-J0-20190329_011445_7713206716645727625526.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/expressions/test/temp/junit4-J2-20190329_011445_79012772288699394224192.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/expressions/test/temp/junit4-J1-20190329_011445_7751965040799369484511.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 234 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/facet/test/temp/junit4-J2-20190329_011500_0181872051611528426594.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/facet/test/temp/junit4-J0-20190329_011500_0189500722508888086752.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/facet/test/temp/junit4-J1-20190329_011500_0183147750842955652334.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 185 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/grouping/test/temp/junit4-J0-20190329_011556_69911865322025467830003.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/grouping/test/temp/junit4-J1-20190329_011556_7148041925554415940275.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/grouping/test/temp/junit4-J2-20190329_011556_7199243494402557678901.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 255 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/highlighter/test/temp/junit4-J1-20190329_011625_25213723597067854941067.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/highlighter/test/temp/junit4-J0-20190329_011625_23933705447039234185.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 6 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/highlighter/test/temp/junit4-J2-20190329_011625_2558111751396928529042.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 166 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/join/test/temp/junit4-J0-20190329_011656_73056206606152806775.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/join/test/temp/junit4-J1-20190329_011656_7398772265431321777275.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/join/test/temp/junit4-J2-20190329_011656_7451581434073595626203.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 157 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/memory/test/temp/junit4-J0-20190329_011739_66713974872279159214842.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/memory/test/temp/junit4-J1-20190329_011739_67611691806944530682425.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 192 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/misc/test/temp/junit4-J2-20190329_011802_3102050289919316146370.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/misc/test/temp/junit4-J0-20190329_011802_3033531863493494115487.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/misc/test/temp/junit4-J1-20190329_011802_30417375347423433854254.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 309 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queries/test/temp/junit4-J2-20190329_011844_7832291362496172034778.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queries/test/temp/junit4-J1-20190329_011844_7703191483346335359110.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queries/test/temp/junit4-J0-20190329_011844_75511998002880093913178.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 234 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queryparser/test/temp/junit4-J2-20190329_011901_7195493574909895878129.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queryparser/test/temp/junit4-J1-20190329_011901_7117212067792812413867.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/queryparser/test/temp/junit4-J0-20190329_011901_6996343493425813547550.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 216 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/replicator/test/temp/junit4-J2-20190329_011917_7767865817460804618353.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/replicator/test/temp/junit4-J1-20190329_011917_75612165505580501595016.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/replicator/test/temp/junit4-J0-20190329_011917_75112897695201707642004.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 248 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/sandbox/test/temp/junit4-J1-20190329_011937_7855216993344984337348.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 5 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/sandbox/test/temp/junit4-J2-20190329_011937_80610577316730449537659.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/sandbox/test/temp/junit4-J0-20190329_011937_7755527126171129879373.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 302 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial-extras/test/temp/junit4-J2-20190329_012114_4523283623749288346304.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial-extras/test/temp/junit4-J1-20190329_012114_4526085724570176375925.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial-extras/test/temp/junit4-J0-20190329_012114_4474763650583004735584.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 153 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial/test/temp/junit4-J0-20190329_012206_20917849560245225768400.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 184 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial3d/test/temp/junit4-J2-20190329_012209_1942652208978946657387.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial3d/test/temp/junit4-J0-20190329_012209_1899976117905136320861.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 5 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/spatial3d/test/temp/junit4-J1-20190329_012209_1903439549659381395858.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 252 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/suggest/test/temp/junit4-J2-20190329_012334_7046326791868425420632.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 6 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/suggest/test/temp/junit4-J1-20190329_012334_69114249865006266620431.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 9 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/lucene/build/suggest/test/temp/junit4-J0-20190329_012334_6792329204288729369650.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 4089 lines...]
[junit4] Suite: org.apache.solr.index.UninvertDocValuesMergePolicyTest
[junit4] 2> 2429846 INFO (SUITE-UninvertDocValuesMergePolicyTest-seed#[FD07CB6CB0AFCB8D]-worker) [ ] o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> Creating dataDir: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.index.UninvertDocValuesMergePolicyTest_FD07CB6CB0AFCB8D-001/init-core-data-001
[junit4] 2> 2429846 WARN (SUITE-UninvertDocValuesMergePolicyTest-seed#[FD07CB6CB0AFCB8D]-worker) [ ] o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=2 numCloses=2
[junit4] 2> 2429846 INFO (SUITE-UninvertDocValuesMergePolicyTest-seed#[FD07CB6CB0AFCB8D]-worker) [ ] o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) w/NUMERIC_DOCVALUES_SYSPROP=false
[junit4] 2> 2429847 INFO (SUITE-UninvertDocValuesMergePolicyTest-seed#[FD07CB6CB0AFCB8D]-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)
[junit4] 2> 2429860 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testNonIndexedFieldDoesNonFail
[junit4] 2> 2429860 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2429861 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2429889 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 2429906 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.IndexSchema [null] Schema name=schema-docValues
[junit4] 2> 2429910 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.IndexSchema Loaded schema schema-docValues/1.6 with uniqueid field id
[junit4] 2> 2430349 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2430350 WARN (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@3034ac3[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2430378 WARN (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@7b061405[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2430393 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2430394 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2430407 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430415 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430415 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430416 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2430426 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 2430435 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=schema-docValues
[junit4] 2> 2430438 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema schema-docValues/1.6 with uniqueid field id
[junit4] 2> 2430438 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2430438 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430438 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.index.UninvertDocValuesMergePolicyTest_FD07CB6CB0AFCB8D-001/init-core-data-001/]
[junit4] 2> 2430467 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2430467 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2430468 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@ebbcb5e[collection1] main]
[junit4] 2> 2430468 WARN (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2430469 INFO (coreLoadExecutor-12039-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2430469 INFO (searcherExecutor-12040-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@ebbcb5e[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2430471 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2430475 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 3
[junit4] 2> 2430476 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2430476 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@498d8129 commitCommandVersion:0
[junit4] 2> 2430494 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@570bfb6b[collection1] main]
[junit4] 2> 2430495 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2430495 INFO (searcherExecutor-12040-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@570bfb6b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825216845}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2430496 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 20
[junit4] 2> 2430497 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2430497 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2430497 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@498d8129 commitCommandVersion:0
[junit4] 2> 2430508 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@7631e7c9[collection1] main]
[junit4] 2> 2430509 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2430509 INFO (searcherExecutor-12040-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@7631e7c9[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825216845}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825216849}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2430515 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 18
[junit4] 2> 2430516 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2430516 WARN (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 Starting optimize... Reading and rewriting the entire index! Use with care.
[junit4] 2> 2430530 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@498d8129 commitCommandVersion:0
[junit4] 2> 2430530 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@df4e62c[collection1] main]
[junit4] 2> 2430532 INFO (searcherExecutor-12040-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@df4e62c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, mergeMaxNumSegments=1, os.arch=amd64, java.runtime.version=11+28, source=merge, mergeFactor=2, os.version=4.18.0-15-generic, timestamp=1553825216879}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2430532 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2430532 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{optimize=} 0 16
[junit4] 2> 2430533 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> 2430533 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.CoreContainer Shutting down CoreContainer instance=191079639
[junit4] 2> 2430555 INFO (coreCloseExecutor-12044-thread-1) [ x:collection1] o.a.s.c.SolrCore [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@554369a
[junit4] 2> 2430555 INFO (coreCloseExecutor-12044-thread-1) [ x:collection1] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.core.collection1, tag=554369a
[junit4] 2> 2430555 INFO (coreCloseExecutor-12044-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3ef7effb: rootName = null, domain = solr.core.collection1, service url = null, agent id = null] for registry solr.core.collection1 / com.codahale.metrics.MetricRegistry@1f1e4964
[junit4] 2> 2430604 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node, tag=null
[junit4] 2> 2430604 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@58ea403: rootName = null, domain = solr.node, service url = null, agent id = null] for registry solr.node / com.codahale.metrics.MetricRegistry@40e9cd90
[junit4] 2> 2430608 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm, tag=null
[junit4] 2> 2430608 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@3f8e181c: rootName = null, domain = solr.jvm, service url = null, agent id = null] for registry solr.jvm / com.codahale.metrics.MetricRegistry@295f278e
[junit4] 2> 2430611 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty, tag=null
[junit4] 2> 2430611 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter Closing reporter [org.apache.solr.metrics.reporters.SolrJmxReporter@704cd99b: rootName = null, domain = solr.jetty, service url = null, agent id = null] for registry solr.jetty / com.codahale.metrics.MetricRegistry@34ed14f
[junit4] 2> 2430625 INFO (TEST-UninvertDocValuesMergePolicyTest.testNonIndexedFieldDoesNonFail-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testNonIndexedFieldDoesNonFail
[junit4] 2> 2430628 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ###Starting testIndexAndAddDocValues
[junit4] 2> 2430628 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ####initCore
[junit4] 2> 2430628 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2430638 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 2430672 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.IndexSchema [null] Schema name=schema-docValues
[junit4] 2> 2430674 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.IndexSchema Loaded schema schema-docValues/1.6 with uniqueid field id
[junit4] 2> 2430793 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized: WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 2430803 WARN (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@1ca598df[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2430858 WARN (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for SslContextFactory@423fab42[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 2430891 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 transient cores
[junit4] 2> 2430892 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.h.a.MetricsHistoryHandler No .system collection, keeping metrics history in memory.
[junit4] 2> 2430903 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.node' (registry 'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430911 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jvm' (registry 'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430911 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.jetty' (registry 'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430912 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.c.SolrResourceLoader [null] Added 2 libs to classloader, from paths: [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib, /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/lib/classes]
[junit4] 2> 2430924 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.1.0
[junit4] 2> 2430928 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.s.IndexSchema [collection1] Schema name=schema-docValues
[junit4] 2> 2430940 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.s.IndexSchema Loaded schema schema-docValues/1.6 with uniqueid field id
[junit4] 2> 2430940 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.c.CoreContainer Creating SolrCore 'collection1' using configuration from instancedir /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1, trusted=true
[junit4] 2> 2430940 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr.core.collection1' (registry 'solr.core.collection1') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@14ad2909
[junit4] 2> 2430940 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.c.SolrCore [[collection1] ] Opening new SolrCore at [/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1], dataDir=[/home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/J0/temp/solr.index.UninvertDocValuesMergePolicyTest_FD07CB6CB0AFCB8D-001/init-core-data-001/]
[junit4] 2> 2431008 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 2431008 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 2431008 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.s.SolrIndexSearcher Opening [Searcher@1f2eff03[collection1] main]
[junit4] 2> 2431009 WARN (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.r.ManagedResourceStorage Cannot write to config directory /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/core/src/test-files/solr/collection1/conf; switching to use InMemory storage instead.
[junit4] 2> 2431009 INFO (coreLoadExecutor-12054-thread-1) [ x:collection1] o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 2431010 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.SolrTestCaseJ4 ####initCore end
[junit4] 2> 2431010 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[0]} 0 0
[junit4] 2> 2431010 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[1]} 0 0
[junit4] 2> 2431010 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431010 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431020 INFO (searcherExecutor-12055-thread-1-processing-x:collection1) [ x:collection1] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@1f2eff03[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 2431020 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@5f3533de[collection1] main]
[junit4] 2> 2431021 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431021 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@5f3533de[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431021 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 11
[junit4] 2> 2431022 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[2]} 0 0
[junit4] 2> 2431022 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[3]} 0 0
[junit4] 2> 2431022 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431022 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431024 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@6f2cb995[collection1] main]
[junit4] 2> 2431024 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431025 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@6f2cb995[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431025 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 2431025 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[4]} 0 0
[junit4] 2> 2431025 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431025 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431027 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@616974fe[collection1] main]
[junit4] 2> 2431027 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431028 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@616974fe[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217377}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431028 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 2431028 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[5]} 0 0
[junit4] 2> 2431029 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[6]} 0 0
[junit4] 2> 2431029 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431029 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431030 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@33966dd6[collection1] main]
[junit4] 2> 2431030 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431031 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@33966dd6[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217377}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_3(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217380}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431031 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[7]} 0 0
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[8]} 0 0
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[9]} 0 0
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[10]} 0 0
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[11]} 0 0
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431032 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431034 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@15adcd75[collection1] main]
[junit4] 2> 2431034 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431035 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@15adcd75[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217377}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_3(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217380}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.1.0):C5:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217384}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431035 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 2431035 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[12]} 0 0
[junit4] 2> 2431036 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[13]} 0 0
[junit4] 2> 2431036 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431036 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431037 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@617d53c0[collection1] main]
[junit4] 2> 2431038 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431038 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@617d53c0[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217377}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_3(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217380}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.1.0):C5:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217384}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217387}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}])))}
[junit4] 2> 2431038 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{commit=} 0 2
[junit4] 2> 2431039 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[14]} 0 0
[junit4] 2> 2431039 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.p.LogUpdateProcessorFactory [collection1] webapp=null path=null params={}{add=[15]} 0 0
[junit4] 2> 2431039 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 2431039 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.SolrIndexWriter Calling setCommitData with IW:org.apache.solr.update.SolrIndexWriter@13f8c0c2 commitCommandVersion:0
[junit4] 2> 2431041 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.s.SolrIndexSearcher Opening [Searcher@4df9ed90[collection1] main]
[junit4] 2> 2431041 INFO (TEST-UninvertDocValuesMergePolicyTest.testIndexAndAddDocValues-seed#[FD07CB6CB0AFCB8D]) [ ] o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 2431042 INFO (searcherExecutor-12055-thread-1) [ ] o.a.s.c.SolrCore [collection1] Registered new searcher Searcher@4df9ed90[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217362}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_1(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217374}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_2(8.1.0):C1:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217377}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_3(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217380}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_4(8.1.0):C5:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217384}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_5(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.version=11+28, lucene.version=8.1.0, os.arch=amd64, java.runtime.version=11+28, source=flush, os.version=4.18.0-15-generic, timestamp=1553825217387}]:[attributes={Lucene50StoredFieldsFormat.mode=BEST_SPEED}]) Uninverting(_6(8.1.0):C2:[diagnostics={os=Linux, java.vendor=Oracle Corporation, java.version=11, java.vm.vers
[...truncated too long message...]
/solr/build/contrib/solr-dataimporthandler/test/temp/junit4-J0-20190329_022042_97817995492740653157056.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-dataimporthandler/test/temp/junit4-J1-20190329_022042_97810711714666407649054.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-dataimporthandler/test/temp/junit4-J2-20190329_022042_9783754502672256601069.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 573 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-cell/test/temp/junit4-J1-20190329_022130_4725299541734507444596.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-cell/test/temp/junit4-J2-20190329_022130_4753787842033382698651.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-cell/test/temp/junit4-J0-20190329_022130_47217322622037909984898.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 581 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-langid/test/temp/junit4-J0-20190329_022151_25415989578482623832235.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-langid/test/temp/junit4-J2-20190329_022151_25811803521367884500531.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-langid/test/temp/junit4-J1-20190329_022151_2541111491201442061432.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 682 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-ltr/test/temp/junit4-J2-20190329_022206_15111420470478506395320.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-ltr/test/temp/junit4-J0-20190329_022206_13517968032554702118621.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-ltr/test/temp/junit4-J1-20190329_022206_13912829932430434547085.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 581 lines...]
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J1-20190329_022250_0523492876606834388455.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 3 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J0-20190329_022250_0527792109445875952407.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 3 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-prometheus-exporter/test/temp/junit4-J2-20190329_022250_0619413909043167987665.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 569 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/contrib/solr-velocity/test/temp/junit4-J0-20190329_022319_9419465870314150898450.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[...truncated 33592 lines...]
[repro] Jenkins log URL: https://jenkins.thetaphi.de/job/Lucene-Solr-8.x-Linux/318/consoleText
[repro] Revision: 03a3562f782a795afb3e5dbb474aca216273cc4d
[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC"
[repro] Repro line: ant test -Dtestcase=UninvertDocValuesMergePolicyTest -Dtests.method=testIndexAndAddDocValues -Dtests.seed=FD07CB6CB0AFCB8D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=jgo -Dtests.timezone=Asia/Atyrau -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[repro] ant clean
[...truncated 6 lines...]
[repro] Test suites by module:
[repro] solr/core
[repro] UninvertDocValuesMergePolicyTest
[repro] ant compile-test
[...truncated 3581 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 -Dtests.class="*.UninvertDocValuesMergePolicyTest" -Dtests.showOutput=onerror "-Dargs=-XX:-UseCompressedOops -XX:+UseConcMarkSweepGC" -Dtests.seed=FD07CB6CB0AFCB8D -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=jgo -Dtests.timezone=Asia/Atyrau -Dtests.asserts=true -Dtests.file.encoding=UTF-8
[...truncated 47 lines...]
[junit4] JVM J2: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J2-20190329_022805_1067101463570718216125.syserr
[junit4] >>> JVM J2 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J2: EOF ----
[...truncated 10 lines...]
[junit4] JVM J0: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J0-20190329_022805_0936432740437597629838.syserr
[junit4] >>> JVM J0 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J0: EOF ----
[junit4] JVM J1: stderr was not empty, see: /home/jenkins/workspace/Lucene-Solr-8.x-Linux/solr/build/solr-core/test/temp/junit4-J1-20190329_022805_0932437602898996682237.syserr
[junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
[junit4] OpenJDK 64-Bit Server VM warning: Option UseConcMarkSweepGC was deprecated in version 9.0 and will likely be removed in a future release.
[junit4] <<< JVM J1: EOF ----
[...truncated 23 lines...]
[repro] Failures:
[repro] 0/5 failed: org.apache.solr.index.UninvertDocValuesMergePolicyTest
[repro] Exiting with code 0
[...truncated 43 lines...]