Build: https://builds.apache.org/job/Lucene-Solr-BadApples-Tests-8.x/105/
1 tests failed.
FAILED:
org.apache.solr.client.solrj.io.stream.MathExpressionTest.testGammaDistribution
Error Message:
0.8270447626785014 0.8286288686448905
Stack Trace:
java.lang.AssertionError: 0.8270447626785014 0.8286288686448905
at
__randomizedtesting.SeedInfo.seed([E3F8F49E99795575:DE82DF30BA01FF62]:0)
at org.junit.Assert.fail(Assert.java:88)
at org.junit.Assert.assertTrue(Assert.java:41)
at
org.apache.solr.client.solrj.io.stream.MathExpressionTest.testGammaDistribution(MathExpressionTest.java:4590)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
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
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.lang.Thread.run(Thread.java:748)
Build Log:
[...truncated 16653 lines...]
[junit4] Suite: org.apache.solr.client.solrj.io.stream.MathExpressionTest
[junit4] 2> Creating dataDir:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/init-core-data-001
[junit4] 2> 187581 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true)
w/NUMERIC_DOCVALUES_SYSPROP=true
[junit4] 2> 187583 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (false) via:
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
[junit4] 2> 187583 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks:
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
[junit4] 2> 187584 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001
[junit4] 2> 187585 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 187592 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer client port:0.0.0.0/0.0.0.0:0
[junit4] 2> 187592 INFO (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Starting server
[junit4] 2> 187692 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:34908
[junit4] 2> 187692 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34908
[junit4] 2> 187692 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 34908
[junit4] 2> 187701 INFO (zkConnectionManagerCallback-925-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187714 INFO (zkConnectionManagerCallback-927-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187716 INFO (zkConnectionManagerCallback-929-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187726 WARN (jetty-launcher-930-thread-1) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 187726 WARN (jetty-launcher-930-thread-2) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 187726 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 187727 WARN (jetty-launcher-930-thread-3) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 187727 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 187730 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 187731 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 187739 WARN (jetty-launcher-930-thread-4) [ ]
o.e.j.s.AbstractConnector Ignoring deprecated socket close linger time
[junit4] 2> 187739 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Start Jetty (original configured port=0)
[junit4] 2> 187739 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Trying to start Jetty on port 0 try number 1 ...
[junit4] 2> 187739 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.Server jetty-9.4.14.v20181114; built: 2018-11-14T21:20:31.478Z; git:
c4550056e785fb5665914545889f21dc136ad9e6; jvm 1.8.0_191-b12
[junit4] 2> 187742 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 187743 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 187743 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 187743 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@70f2da73{/solr,null,AVAILABLE}
[junit4] 2> 187746 WARN (jetty-launcher-930-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3d57f779[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187749 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 187749 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 187749 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 187749 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@3a9acf34{/solr,null,AVAILABLE}
[junit4] 2> 187750 WARN (jetty-launcher-930-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5e51aba0[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@3e158b6f{SSL,[ssl,
http/1.1]}{127.0.0.1:39665}
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-3) [ ]
o.e.j.s.Server Started @187827ms
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=39665}
[junit4] 2> 187757 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@10fc2a14{/solr,null,AVAILABLE}
[junit4] 2> 187758 ERROR (jetty-launcher-930-thread-3) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 187758 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 187758 WARN (jetty-launcher-930-thread-4) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@5f359aed[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187758 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 187758 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 187758 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 187758 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-05-19T09:46:08.402Z
[junit4] 2> 187760 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@1c9b6f82{SSL,[ssl,
http/1.1]}{127.0.0.1:45733}
[junit4] 2> 187760 INFO (jetty-launcher-930-thread-1) [ ]
o.e.j.s.Server Started @187830ms
[junit4] 2> 187760 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=45733}
[junit4] 2> 187760 ERROR (jetty-launcher-930-thread-1) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 187760 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 187763 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 187763 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 187763 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 187763 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-05-19T09:46:08.407Z
[junit4] 2> 187765 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.session DefaultSessionIdManager workerName=node0
[junit4] 2> 187765 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.session No SessionScavenger set, using defaults
[junit4] 2> 187765 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.session node0 Scavenging every 600000ms
[junit4] 2> 187770 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@539f6b5{/solr,null,AVAILABLE}
[junit4] 2> 187770 WARN (jetty-launcher-930-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@2fd86eb2[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@43260df0{SSL,[ssl,
http/1.1]}{127.0.0.1:35182}
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.e.j.s.Server Started @187843ms
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=35182}
[junit4] 2> 187773 ERROR (jetty-launcher-930-thread-4) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 187773 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 187774 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-05-19T09:46:08.417Z
[junit4] 2> 187777 INFO (zkConnectionManagerCallback-932-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.AbstractConnector Started ServerConnector@ac41960{SSL,[ssl,
http/1.1]}{127.0.0.1:37266}
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.e.j.s.Server Started @187847ms
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=37266}
[junit4] 2> 187777 ERROR (jetty-launcher-930-thread-2) [ ]
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be
missing or incomplete.
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter Using logger factory
org.apache.logging.slf4j.Log4jLoggerFactory
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr? version
8.2.0
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 187777 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 187778 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2019-05-19T09:46:08.421Z
[junit4] 2> 187778 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 187778 INFO (zkConnectionManagerCallback-936-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187784 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 187785 INFO (zkConnectionManagerCallback-934-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187785 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 187786 INFO (zkConnectionManagerCallback-938-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187787 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 187931 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 187931 WARN (jetty-launcher-930-thread-3) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 187964 WARN (jetty-launcher-930-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1d7b98fc[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187975 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 187975 WARN (jetty-launcher-930-thread-2) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 187976 WARN (jetty-launcher-930-thread-3) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 187976 WARN (jetty-launcher-930-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@42b69379[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187979 WARN (jetty-launcher-930-thread-2) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 187980 WARN (jetty-launcher-930-thread-3) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3498eb06[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187981 INFO (jetty-launcher-930-thread-3) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34908/solr
[junit4] 2> 187981 WARN (jetty-launcher-930-thread-2) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@35410a6c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 187982 INFO (jetty-launcher-930-thread-2) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34908/solr
[junit4] 2> 187985 INFO (zkConnectionManagerCallback-954-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187991 INFO (zkConnectionManagerCallback-951-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 187992 INFO (zkConnectionManagerCallback-956-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188008 WARN (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.ZkController The _default configset could
not be uploaded. Please provide 'solr.default.confdir' parameter that points to
a configset intended to be the default. Current 'solr.default.confdir' value:
null
[junit4] 2> 188008 INFO (zkConnectionManagerCallback-958-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188014 WARN (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.c.ZkController The _default configset could
not be uploaded. Please provide 'solr.default.confdir' parameter that points to
a configset intended to be the default. Current 'solr.default.confdir' value:
null
[junit4] 2> 188016 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:37266_solr
[junit4] 2> 188017 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.Overseer Overseer
(id=73328593821040649-127.0.0.1:37266_solr-n_0000000000) starting
[junit4] 2> 188021 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:39665_solr
[junit4] 2> 188025 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 188040 INFO (zkConnectionManagerCallback-967-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188041 INFO (zkConnectionManagerCallback-972-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188042 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 188043 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 188043 INFO (zkCallback-955-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 188044 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:34908/solr ready
[junit4] 2> 188048 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:34908/solr ready
[junit4] 2> 188061 INFO
(OverseerStateUpdate-73328593821040649-127.0.0.1:37266_solr-n_0000000000)
[n:127.0.0.1:37266_solr ] o.a.s.c.Overseer Starting to work on the main
queue : 127.0.0.1:37266_solr
[junit4] 2> 188068 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:37266_solr as DOWN
[junit4] 2> 188070 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 188070 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:37266_solr
[junit4] 2> 188074 INFO (zkCallback-955-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 188075 INFO (zkCallback-966-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 188085 INFO (zkCallback-971-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 188085 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (2)
[junit4] 2> 188097 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 188115 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 188170 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37266.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188171 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39665.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188199 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39665.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188200 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_39665.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188201 INFO (jetty-launcher-930-thread-3)
[n:127.0.0.1:39665_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node2/.
[junit4] 2> 188224 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37266.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188228 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_37266.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188230 INFO (jetty-launcher-930-thread-2)
[n:127.0.0.1:37266_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node3/.
[junit4] 2> 188264 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 188265 WARN (jetty-launcher-930-thread-4) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 188266 WARN (jetty-launcher-930-thread-4) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@1aaf300c[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 188269 WARN (jetty-launcher-930-thread-4) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 188270 WARN (jetty-launcher-930-thread-4) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@49d4a1cb[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 188271 INFO (jetty-launcher-930-thread-4) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34908/solr
[junit4] 2> 188284 INFO (zkConnectionManagerCallback-980-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188305 INFO (zkConnectionManagerCallback-982-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188314 WARN (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.ZkController The _default configset could
not be uploaded. Please provide 'solr.default.confdir' parameter that points to
a configset intended to be the default. Current 'solr.default.confdir' value:
null
[junit4] 2> 188316 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (2)
[junit4] 2> 188328 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:35182_solr as DOWN
[junit4] 2> 188330 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 188330 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:35182_solr
[junit4] 2> 188332 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 188332 INFO (zkCallback-971-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 188332 INFO (zkCallback-955-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 188332 INFO (zkCallback-966-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 188336 INFO (zkCallback-981-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
[junit4] 2> 188337 INFO (zkConnectionManagerCallback-989-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188339 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 188346 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:34908/solr ready
[junit4] 2> 188374 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 188398 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35182.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188412 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35182.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188412 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35182.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188416 INFO (jetty-launcher-930-thread-4)
[n:127.0.0.1:35182_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node4/.
[junit4] 2> 188587 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.h.c.HttpShardHandlerFactory Host whitelist initialized:
WhitelistHostChecker [whitelistHosts=null, whitelistHostCheckingEnabled=true]
[junit4] 2> 188587 WARN (jetty-launcher-930-thread-1) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 188590 WARN (jetty-launcher-930-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@705b6dd1[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 188595 WARN (jetty-launcher-930-thread-1) [ ]
o.a.s.c.s.i.Http2SolrClient Create Http2SolrClient with HTTP/1.1 transport
since Java 8 or lower versions does not support SSL + HTTP/2
[junit4] 2> 188596 WARN (jetty-launcher-930-thread-1) [ ]
o.e.j.u.s.S.config No Client EndPointIdentificationAlgorithm configured for
SslContextFactory@3c8a09a8[provider=null,keyStore=null,trustStore=null]
[junit4] 2> 188597 INFO (jetty-launcher-930-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34908/solr
[junit4] 2> 188600 INFO (zkConnectionManagerCallback-996-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188605 INFO (zkConnectionManagerCallback-998-thread-1) [ ]
o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188611 WARN (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.ZkController The _default configset could
not be uploaded. Please provide 'solr.default.confdir' parameter that points to
a configset intended to be the default. Current 'solr.default.confdir' value:
null
[junit4] 2> 188612 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (3)
[junit4] 2> 188617 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.ZkController Publish
node=127.0.0.1:45733_solr as DOWN
[junit4] 2> 188620 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.TransientSolrCoreCacheDefault Allocating
transient cache for 2147483647 transient cores
[junit4] 2> 188620 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:45733_solr
[junit4] 2> 188622 INFO (zkCallback-955-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188622 INFO (zkCallback-957-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188623 INFO (zkCallback-971-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188623 INFO (zkCallback-966-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188623 INFO (zkCallback-981-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188626 INFO (zkConnectionManagerCallback-1005-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188627 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (4)
[junit4] 2> 188628 INFO (zkCallback-997-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188628 INFO (zkCallback-988-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
[junit4] 2> 188629 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster
at 127.0.0.1:34908/solr ready
[junit4] 2> 188659 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.h.a.MetricsHistoryHandler No .system
collection, keeping metrics history in memory.
[junit4] 2> 188683 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45733.solr.node' (registry 'solr.node') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188697 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45733.solr.jvm' (registry 'solr.jvm') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188697 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45733.solr.jetty' (registry 'solr.jetty') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 188698 INFO (jetty-launcher-930-thread-1)
[n:127.0.0.1:45733_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node1/.
[junit4] 2> 188769 INFO (zkConnectionManagerCallback-1011-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 188770 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 188774 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34908/solr ready
[junit4] 2> 188802 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 188808 INFO
(OverseerThreadFactory-548-thread-1-processing-n:127.0.0.1:37266_solr)
[n:127.0.0.1:37266_solr ] o.a.s.c.a.c.CreateCollectionCmd Create collection
collection1
[junit4] 2> 188925 INFO
(OverseerStateUpdate-73328593821040649-127.0.0.1:37266_solr-n_0000000000)
[n:127.0.0.1:37266_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard1",
[junit4] 2> "core":"collection1_shard1_replica_n1",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:45733/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 188935 INFO
(OverseerStateUpdate-73328593821040649-127.0.0.1:37266_solr-n_0000000000)
[n:127.0.0.1:37266_solr ] o.a.s.c.o.SliceMutator createReplica() {
[junit4] 2> "operation":"ADDREPLICA",
[junit4] 2> "collection":"collection1",
[junit4] 2> "shard":"shard2",
[junit4] 2> "core":"collection1_shard2_replica_n3",
[junit4] 2> "state":"down",
[junit4] 2> "base_url":"https://127.0.0.1:35182/solr",
[junit4] 2> "type":"NRT",
[junit4] 2> "waitForFinalState":"false"}
[junit4] 2> 189180 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
x:collection1_shard1_replica_n1] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 189191 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
x:collection1_shard2_replica_n3] o.a.s.h.a.CoreAdminOperation core create
command
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n3&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
[junit4] 2> 190219 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 190220 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.2.0
[junit4] 2> 190240 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
[junit4] 2> 190240 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.IndexSchema [collection1_shard2_replica_n3] Schema name=test
[junit4] 2> 190350 WARN (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for
multiple copyFields (2)
[junit4] 2> 190350 WARN (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple
copyFields (3)
[junit4] 2> 190351 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 190351 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using
configuration from collection collection1, trusted=true
[junit4] 2> 190352 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_45733.solr.core.collection1.shard1.replica_n1' (registry
'solr.core.collection1.shard1.replica_n1') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 190352 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node1/collection1_shard1_replica_n1],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
[junit4] 2> 190409 WARN (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for
multiple copyFields (2)
[junit4] 2> 190409 WARN (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple
copyFields (3)
[junit4] 2> 190410 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
[junit4] 2> 190410 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n3' using
configuration from collection collection1, trusted=true
[junit4] 2> 190410 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.m.r.SolrJmxReporter JMX monitoring for
'solr_35182.solr.core.collection1.shard2.replica_n3' (registry
'solr.core.collection1.shard2.replica_n3') enabled at server:
com.sun.jmx.mbeanserver.JmxMBeanServer@34d70843
[junit4] 2> 190411 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.SolrCore [[collection1_shard2_replica_n3] ] Opening new SolrCore at
[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node4/collection1_shard2_replica_n3],
dataDir=[/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001/tempDir-001/node4/./collection1_shard2_replica_n3/data/]
[junit4] 2> 190438 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 190438 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 190439 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 190439 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 190441 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@7839d4d1[collection1_shard1_replica_n1] main]
[junit4] 2> 190446 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 190447 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 190447 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 190448 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1633953168586964992
[junit4] 2> 190462 INFO
(searcherExecutor-570-thread-1-processing-n:127.0.0.1:45733_solr
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node2)
[n:127.0.0.1:45733_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@7839d4d1[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 190476 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard1 to Terms{values={core_node2=0}, version=0}
[junit4] 2> 190476 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection1/leaders/shard1
[junit4] 2> 190480 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 190480 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 190480 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/
[junit4] 2> 190482 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 190482 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.SyncStrategy
https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/ has no replicas
[junit4] 2> 190482 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection1/leaders/shard1/leader after winning as
/collections/collection1/leader_elect/shard1/election/73328593821040657-core_node2-n_0000000000
[junit4] 2> 190486 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/ shard1
[junit4] 2> 190524 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 190524 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 190526 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 190526 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 190531 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@11e5f89[collection1_shard2_replica_n3] main]
[junit4] 2> 190534 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 190534 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 190535 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
[junit4] 2> 190535 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using
new clock 1633953168678191104
[junit4] 2> 190541 INFO
(searcherExecutor-571-thread-1-processing-n:127.0.0.1:35182_solr
x:collection1_shard2_replica_n3 c:collection1 s:shard2 r:core_node4)
[n:127.0.0.1:35182_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n3] o.a.s.c.SolrCore
[collection1_shard2_replica_n3] Registered new searcher
Searcher@11e5f89[collection1_shard2_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 190547 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard2 to Terms{values={core_node4=0}, version=0}
[junit4] 2> 190547 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContextBase make sure parent is created
/collections/collection1/leaders/shard2
[junit4] 2> 190552 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 190553 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 190553 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.SyncStrategy Sync replicas to
https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/
[junit4] 2> 190563 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
[junit4] 2> 190564 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.SyncStrategy
https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/ has no replicas
[junit4] 2> 190564 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContextBase Creating leader registration node
/collections/collection1/leaders/shard2/leader after winning as
/collections/collection1/leader_elect/shard2/election/73328593821040654-core_node4-n_0000000000
[junit4] 2> 190567 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/ shard2
[junit4] 2> 190670 INFO (zkCallback-997-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: [4])
[junit4] 2> 190670 INFO (zkCallback-981-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: [4])
[junit4] 2> 190672 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 190672 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ZkController I am the leader, no recovery necessary
[junit4] 2> 190677 INFO (zkCallback-997-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: [4])
[junit4] 2> 190677 INFO (zkCallback-981-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: [4])
[junit4] 2> 190678 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n3&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1487
[junit4] 2> 190680 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores
params={qt=/admin/cores&coreNodeName=core_node2&collection.configName=conf&newCollection=true&name=collection1_shard1_replica_n1&action=CREATE&numShards=2&collection=collection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
status=0 QTime=1500
[junit4] 2> 190693 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
45 seconds. Check all shard replicas
[junit4] 2> 190789 INFO (zkCallback-997-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: [4])
[junit4] 2> 190789 INFO (zkCallback-997-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: [4])
[junit4] 2> 190789 INFO (zkCallback-981-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: [4])
[junit4] 2> 190789 INFO (zkCallback-981-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: [4])
[junit4] 2> 190791 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
status=0 QTime=1989
[junit4] 2> 190792 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
collection1 failOnTimeout:true timeout (sec):45
[junit4] 2> 190800 INFO (zkCallback-997-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 190808 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
[junit4] 2> 190829 INFO (zkCallback-981-thread-3) [ ]
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent
state:SyncConnected type:NodeDataChanged
path:/collections/collection1/state.json] for collection [collection1] has
occurred - updating... (live nodes size: [4])
[junit4] 2> 190888 INFO
(OverseerCollectionConfigSetProcessor-73328593821040649-127.0.0.1:37266_solr-n_0000000000)
[n:127.0.0.1:37266_solr ] 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> 191024 INFO
(TEST-MathExpressionTest.testDescribe-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testDescribe
[junit4] 2> 191191 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard2 to Terms{values={core_node4=1}, version=1}
[junit4] 2> 191192 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953169362911232)} 0 3
[junit4] 2> 191196 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953169371299840,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 191197 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 191199 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 191199 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 3
[junit4] 2> 191202 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953169377591296,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 191202 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 191213 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 191213 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.ZkShardTerms Successful update of terms at
/collections/collection1/terms/shard1 to Terms{values={core_node2=1}, version=1}
[junit4] 2> 191214 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953169207721984),commit=} 0 177
[junit4] 2> 191260 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[1
(1633953169434214400), 4 (1633953169438408704)]} 0 4
[junit4] 2> 191267 INFO (qtp715068116-2648) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[2
(1633953169434214400), 3 (1633953169444700160), 5 (1633953169444700161), 6
(1633953169444700162), 7 (1633953169445748736)]} 0 12
[junit4] 2> 191453 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953169640783872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 191453 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@b08c336
commitCommandVersion:1633953169640783872
[junit4] 2> 191465 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@53e3c362[collection1_shard1_replica_n1] main]
[junit4] 2> 191470 INFO
(searcherExecutor-570-thread-1-processing-n:127.0.0.1:45733_solr
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node2)
[n:127.0.0.1:45733_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@53e3c362[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(_0(8.2.0):c2:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=8.2.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic,
timestamp=1558259172106}]))}
[junit4] 2> 191471 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 191471 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 18
[junit4] 2> 191480 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953169669095424,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 191497 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1482626e
commitCommandVersion:1633953169669095424
[junit4] 2> 191510 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@2ac8ca71[collection1_shard2_replica_n3] main]
[junit4] 2> 191510 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 191512 INFO
(searcherExecutor-571-thread-1-processing-n:127.0.0.1:35182_solr
x:collection1_shard2_replica_n3 c:collection1 s:shard2 r:core_node4)
[n:127.0.0.1:35182_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n3] o.a.s.c.SolrCore
[collection1_shard2_replica_n3] Registered new searcher
Searcher@2ac8ca71[collection1_shard2_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader(_0(8.2.0):c5:[diagnostics={os=Linux,
java.vendor=Oracle Corporation, java.version=1.8.0_191,
java.vm.version=25.191-b12, lucene.version=8.2.0, os.arch=amd64,
java.runtime.version=1.8.0_191-b12, source=flush, os.version=4.4.0-137-generic,
timestamp=1558259172150}]))}
[junit4] 2> 191513 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{commit=} 0
244
[junit4] 2> 191582 INFO (qtp1701003413-2629) [n:127.0.0.1:39665_solr ]
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647
transient cores
[junit4] 2> 191597 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/stream
params={indent=off&expr=let(a%3Dsearch(collection1,+q%3D"col_s:a",+fl%3D"price_f,+order_i",+sort%3D"order_i+asc"),+b%3Dcol(a,+price_f),++stats%3Ddescribe(b))&wt=json&version=2.2}
status=0 QTime=8
[junit4] 2> 191602 INFO (zkConnectionManagerCallback-1018-thread-1) [
] o.a.s.c.c.ConnectionManager zkClient has connected
[junit4] 2> 191605 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
[junit4] 2> 191609 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34908/solr ready
[junit4] 2> 191786 INFO (qtp715068116-2648) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&shards.purpose=4&start=0&fsv=true&sort=order_i+asc&shard.url=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&rows=10&version=2&q=col_s:a&NOW=1558259172261&isShard=true&wt=javabin}
hits=5 status=0 QTime=0
[junit4] 2> 191788 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select
params={df=text&distrib=false&_stateVer_=collection1:4&fl=id&shards.purpose=4&start=0&fsv=true&sort=order_i+asc&shard.url=https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/&rows=10&version=2&q=col_s:a&NOW=1558259172261&isShard=true&wt=javabin}
hits=2 status=0 QTime=7
[junit4] 2> 191854 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/select
params={q=col_s:a&df=text&distrib=false&_stateVer_=collection1:4&fl=price_f,+order_i&fl=id&shards.purpose=64&NOW=1558259172261&ids=2,3,5,6,7&isShard=true&shard.url=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 191869 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/select
params={q=col_s:a&df=text&distrib=false&_stateVer_=collection1:4&fl=price_f,+order_i&fl=id&shards.purpose=64&NOW=1558259172261&ids=1,4&isShard=true&shard.url=https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}
status=0 QTime=0
[junit4] 2> 191885 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/select
params={q=col_s:a&_stateVer_=collection1:4&fl=price_f,+order_i&sort=order_i+asc&wt=javabin&version=2}
hits=7 status=0 QTime=268
[junit4] 2> 191902 INFO
(TEST-MathExpressionTest.testDescribe-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testDescribe
[junit4] 2> 192027 INFO
(TEST-MathExpressionTest.testChiSquareDataSet-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testChiSquareDataSet
[junit4] 2> 192033 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@90a778c[collection1_shard2_replica_n3] realtime]
[junit4] 2> 192036 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@2a3e883e[collection1_shard1_replica_n1] realtime]
[junit4] 2> 192036 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170250006528)} 0 2
[junit4] 2> 192047 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170263638016,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192049 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@b08c336
commitCommandVersion:1633953170263638016
[junit4] 2> 192050 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@17ce10ba[collection1_shard1_replica_n1] main]
[junit4] 2> 192050 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192052 INFO
(searcherExecutor-570-thread-1-processing-n:127.0.0.1:45733_solr
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node2)
[n:127.0.0.1:45733_solr c:collection1 s:shard1 r:core_node2
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore
[collection1_shard1_replica_n1] Registered new searcher
Searcher@17ce10ba[collection1_shard1_replica_n1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 192052 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 6
[junit4] 2> 192064 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170281463808,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192064 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@1482626e
commitCommandVersion:1633953170281463808
[junit4] 2> 192064 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.s.SolrIndexSearcher Opening
[Searcher@2d9a100d[collection1_shard2_replica_n3] main]
[junit4] 2> 192065 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192066 INFO
(searcherExecutor-571-thread-1-processing-n:127.0.0.1:35182_solr
x:collection1_shard2_replica_n3 c:collection1 s:shard2 r:core_node4)
[n:127.0.0.1:35182_solr c:collection1 s:shard2 r:core_node4
x:collection1_shard2_replica_n3] o.a.s.c.SolrCore
[collection1_shard2_replica_n3] Registered new searcher
Searcher@2d9a100d[collection1_shard2_replica_n3]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 192067 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170244763648),commit=} 0 38
[junit4] 2> 192084 INFO (qtp715068116-2648) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/stream
params={indent=off&expr=let(echo%3Dtrue,++++a%3Darray(1,1,2,3,4,5,6,7,9,10,11,12),+++++b%3Darray(1,1,2,3,4,5,6,7,1,1,1,1),+++++chisquare%3DchiSquareDataSet(a,+b))&wt=json&version=2.2}
status=0 QTime=2
[junit4] 2> 192098 INFO
(TEST-MathExpressionTest.testChiSquareDataSet-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testChiSquareDataSet
[junit4] 2> 192227 INFO
(TEST-MathExpressionTest.testNatural-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testNatural
[junit4] 2> 192231 INFO (qtp487406579-2641) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170455527424)} 0 1
[junit4] 2> 192252 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170478596096,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192252 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 192252 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192252 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 192257 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170483838976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192257 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 192257 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192257 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170454478848),commit=} 0 28
[junit4] 2> 192269 INFO (qtp487406579-2640) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.c.S.Request [collection1_shard1_replica_n1] webapp=/solr path=/stream
params={indent=off&expr=natural(6)&wt=json&version=2.2} status=0 QTime=0
[junit4] 2> 192272 INFO
(TEST-MathExpressionTest.testNatural-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testNatural
[junit4] 2> 192385 INFO
(TEST-MathExpressionTest.testGammaDistribution-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testGammaDistribution
[junit4] 2> 192391 INFO (qtp487406579-2641) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170622251008)} 0 2
[junit4] 2> 192410 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170644271104,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192410 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 192410 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192410 INFO (qtp487406579-2637) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 192411 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953170645319680,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 192411 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 192412 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 192412 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953170619105280),commit=} 0 26
[junit4] 2> 192421 INFO (qtp715068116-2650) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/stream
params={indent=off&expr=#comment%0alet(echo%3Dtrue,+a%3Ddescribe(sample(gammaDistribution(1,+10),10000)),+%0a#+commment%0ab%3Ddescribe(sample(gammaDistribution(3,+10),10000)),+c%3Ddescribe(sample(gammaDistribution(5,+10),10000)),d%3Ddescribe(sample(gammaDistribution(7,+10),10000)),e%3Dmean(sample(gammaDistribution(1,+10),10000)),f%3Dmean(sample(gammaDistribution(1,+20),10000)),g%3Dmean(sample(gammaDistribution(1,+30),10000)))&wt=json&version=2.2}
status=0 QTime=2
[junit4] 2> 193039 INFO
(TEST-MathExpressionTest.testGammaDistribution-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testGammaDistribution
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=MathExpressionTest
-Dtests.method=testGammaDistribution -Dtests.seed=E3F8F49E99795575
-Dtests.multiplier=2 -Dtests.slow=true -Dtests.badapples=true -Dtests.locale=cs
-Dtests.timezone=Pacific/Pitcairn -Dtests.asserts=true
-Dtests.file.encoding=US-ASCII
[junit4] FAILURE 0.78s J0 | MathExpressionTest.testGammaDistribution <<<
[junit4] > Throwable #1: java.lang.AssertionError: 0.8270447626785014
0.8286288686448905
[junit4] > at
__randomizedtesting.SeedInfo.seed([E3F8F49E99795575:DE82DF30BA01FF62]:0)
[junit4] > at
org.apache.solr.client.solrj.io.stream.MathExpressionTest.testGammaDistribution(MathExpressionTest.java:4590)
[junit4] > at java.lang.Thread.run(Thread.java:748)
[junit4] 2> 193124 INFO
(TEST-MathExpressionTest.testSumSq-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSumSq
[junit4] 2> 193128 INFO (qtp487406579-2638) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953171396100096)} 0 1
[junit4] 2> 193131 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953171400294400,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 193131 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 193131 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 193132 INFO (qtp487406579-2639) [n:127.0.0.1:45733_solr
c:collection1 s:shard1 r:core_node2 x:collection1_shard1_replica_n1]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]
webapp=/solr path=/update
params={update.distrib=TOLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=https://127.0.0.1:35182/solr/collection1_shard2_replica_n3/&commit_end_point=leaders&wt=javabin&version=2&expungeDeletes=false}{commit=}
0 1
[junit4] 2> 193133 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953171402391552,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 193133 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 193133 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 193133 INFO (qtp715068116-2647) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953171395051520),commit=} 0 7
[junit4] 2> 193140 INFO (qtp715068116-2648) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.c.S.Request [collection1_shard2_replica_n3] webapp=/solr path=/stream
params={indent=off&expr=sumSq(array(-3,-2.5,+10))&wt=json&version=2.2} status=0
QTime=1
[junit4] 2> 193142 INFO
(TEST-MathExpressionTest.testSumSq-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testSumSq
[junit4] 2> 193228 INFO
(TEST-MathExpressionTest.testScale-seed#[E3F8F49E99795575]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testScale
[junit4] 2> 193232 INFO (qtp715068116-2646) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n3]
webapp=/solr path=/update
params={update.distrib=TOLEADER&distrib.from=https://127.0.0.1:45733/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
(-1633953171505152000)} 0 1
[junit4] 2> 193238 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 start
commit{_version_=1633953171512492032,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 193238 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 193239 INFO (qtp715068116-2649) [n:127.0.0.1:35182_solr
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n3]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4]
[...truncated too long message...]
] o.a.s.m.SolrMetricManager Closing metric reporters for
registry=solr.node, tag=null
[junit4] 2> 220772 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.node,
tag=null
[junit4] 2> 220773 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@201cf1f: rootName =
solr_45733, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@56676757
[junit4] 2> 220773 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@780e8123: rootName =
solr_35182, domain = solr.node, service url = null, agent id = null] for
registry solr.node / com.codahale.metrics.MetricRegistry@6a742906
[junit4] 2> 220781 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 220781 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jvm,
tag=null
[junit4] 2> 220781 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@2fb0556: rootName =
solr_35182, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@5617ac2f
[junit4] 2> 220781 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@41c577fa: rootName =
solr_45733, domain = solr.jvm, service url = null, agent id = null] for
registry solr.jvm / com.codahale.metrics.MetricRegistry@5617ac2f
[junit4] 2> 220784 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 220784 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@4d5e08f9: rootName =
solr_45733, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@119f175d
[junit4] 2> 220785 INFO (jetty-closer-1026-thread-4) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 220787 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.jetty,
tag=null
[junit4] 2> 220787 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.r.SolrJmxReporter Closing reporter
[org.apache.solr.metrics.reporters.SolrJmxReporter@1f95795c: rootName =
solr_35182, domain = solr.jetty, service url = null, agent id = null] for
registry solr.jetty / com.codahale.metrics.MetricRegistry@119f175d
[junit4] 2> 220787 INFO (jetty-closer-1026-thread-3) [ ]
o.a.s.m.SolrMetricManager Closing metric reporters for registry=solr.cluster,
tag=null
[junit4] 2> 220800 INFO (zkCallback-988-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
[junit4] 2> 220801 INFO (zkCallback-988-thread-1) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (0)
[junit4] 2> 220809 INFO (jetty-closer-1026-thread-4) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@1c9b6f82{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 220814 INFO (jetty-closer-1026-thread-4) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@3a9acf34{/solr,null,UNAVAILABLE}
[junit4] 2> 220815 INFO (jetty-closer-1026-thread-4) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 220820 INFO (jetty-closer-1026-thread-3) [ ]
o.e.j.s.AbstractConnector Stopped ServerConnector@43260df0{SSL,[ssl,
http/1.1]}{127.0.0.1:0}
[junit4] 2> 220828 INFO (jetty-closer-1026-thread-3) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@10fc2a14{/solr,null,UNAVAILABLE}
[junit4] 2> 220828 INFO (jetty-closer-1026-thread-3) [ ]
o.e.j.s.session node0 Stopped scavenging
[junit4] 2> 220831 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer Shutting down ZkTestServer.
[junit4] 2> 220838 WARN (ZkTestServer Run Thread) [ ]
o.a.s.c.ZkTestServer Watch limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/aliases.json
[junit4] 2> 4 /solr/security.json
[junit4] 2> 3 /solr/collections/collection1/terms/shard2
[junit4] 2> 3 /solr/collections/collection1/terms/shard1
[junit4] 2> 2 /solr/configs/conf
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 17 /solr/collections/collection1/state.json
[junit4] 2> 10 /solr/clusterstate.json
[junit4] 2> 10 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 10 /solr/live_nodes
[junit4] 2> 10 /solr/collections
[junit4] 2>
[junit4] 2> 220843 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer parse host and port list: 127.0.0.1:34908
[junit4] 2> 220843 INFO
(SUITE-MathExpressionTest-seed#[E3F8F49E99795575]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1 34908
[junit4] 2> NOTE: leaving temporary files on disk at:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.MathExpressionTest_E3F8F49E99795575-001
[junit4] 2> May 19, 2019 9:46:41 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 3 leaked
thread(s).
[junit4] 2> NOTE: test params are:
codec=FastCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST,
chunkSize=10, maxDocsPerChunk=180, blockSize=1),
termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST,
chunkSize=10, blockSize=1)),
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@49e86d7e),
locale=cs, timezone=Pacific/Pitcairn
[junit4] 2> NOTE: Linux 4.4.0-137-generic amd64/Oracle Corporation
1.8.0_191 (64-bit)/cpus=4,threads=1,free=131541400,total=407371776
[junit4] 2> NOTE: All tests run in this JVM: [RegressionEvaluatorTest,
TestValidatingJsonMap, HeatmapFacetMapTest, CommonParamsTest,
CloudHttp2SolrClientMultiConstructorTest, NormalizeEvaluatorTest,
ConcurrentUpdateHttp2SolrClientBadInputTest, ExclusiveOrEvaluatorTest,
SolrExceptionTest, SolrExampleXMLHttp2Test, SolrPingTest,
SolrExampleEmbeddedTest, CloudSolrClientBadInputTest,
HyperbolicSineEvaluatorTest, DocumentAnalysisResponseTest, JDBCStreamTest,
DivideEvaluatorTest, TestObjectBuilder, TestFastWriter, TangentEvaluatorTest,
ArcCosineEvaluatorTest, PowerEvaluatorTest, HttpClientUtilTest,
ConcatOperationTest, TestJsonRecordReader, CosineEvaluatorTest,
JsonRequestApiHeatmapFacetingTest, JsonQueryRequestIntegrationTest,
LargeVolumeEmbeddedTest, LBHttpSolrClientBuilderTest, SolrParamTest, GraphTest,
JsonRequestApiTest, UsingSolrJRefGuideExamplesTest, ZkConfigFilesTest,
CollectionAdminRequestRequiredParamsTest, GetByIdTest,
SolrExampleBinaryHttp2Test, SolrQueryTest, SolrSchemalessExampleTest,
TestBatchUpdate, TestSolrJErrorHandling, SolrExampleStreamingHttp2Test,
BasicHttpSolrClientTest, CloudSolrClientCacheTest,
ConcurrentUpdateHttp2SolrClientTest, HttpSolrClientBadInputTest,
HttpSolrClientBuilderTest, HttpSolrClientConPoolTest,
HttpSolrClientSSLAuthConPoolTest, TestCloudSolrClientConnections,
MathExpressionTest]
[junit4] Completed [124/196 (1!)] on J0 in 33.61s, 119 tests, 1 failure <<<
FAILURES!
[...truncated 49053 lines...]
[asciidoctor:convert] asciidoctor: ERROR: about-this-guide.adoc: line 1:
invalid part, must have at least one section (e.g., chapter, appendix, etc.)
[asciidoctor:convert] asciidoctor: ERROR: solr-glossary.adoc: line 1: invalid
part, must have at least one section (e.g., chapter, appendix, etc.)
[java] Processed 2531 links (2070 relative) to 3359 anchors in 253 files
[echo] Validated Links & Anchors via:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/solr-ref-guide/bare-bones-html/
-documentation-lint:
[jtidy] Checking for broken html (such as invalid tags)...
[delete] Deleting directory
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/build/jtidy_tmp
[echo] Checking for broken links...
[exec]
[exec] Crawl/parse...
[exec]
[exec] Verify...
[echo] Checking for malformed docs...
[exec]
[exec]
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build/docs/solr-solrj/overview-summary.html
[exec] missing description: org.noggit
[exec]
[exec] Missing javadocs were found!
BUILD FAILED
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/build.xml:643:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/build.xml:101:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build.xml:660:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/solr/build.xml:676:
The following error occurred while executing this line:
/x1/jenkins/jenkins-slave/workspace/Lucene-Solr-BadApples-Tests-8.x/lucene/common-build.xml:2530:
exec returned: 1
Total time: 111 minutes 11 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]