Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4532/
Java: 64bit/jdk1.8.0 -XX:-UseCompressedOops -XX:+UseG1GC

1 tests failed.
FAILED:  
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testGammaDistribution

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([177EBE4810735FE8:2A0495E6330BF5FF]:0)
        at org.junit.Assert.fail(Assert.java:92)
        at org.junit.Assert.assertTrue(Assert.java:43)
        at org.junit.Assert.assertTrue(Assert.java:54)
        at 
org.apache.solr.client.solrj.io.stream.StreamExpressionTest.testGammaDistribution(StreamExpressionTest.java:8650)
        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:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
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 1844 lines...]
   [junit4] JVM J1: stdout was not empty, see: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/lucene/build/core/test/temp/junit4-J1-20180328_145150_3946079273201211086573.sysout
   [junit4] >>> JVM J1 emitted unexpected output (verbatim) ----
   [junit4] codec: HighCompressionCompressingStoredFields, pf: MockRandom, dvf: 
Memory
   [junit4] <<< JVM J1: EOF ----

[...truncated 13772 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/init-core-data-001
   [junit4]   2> 87140 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 87141 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN) 
w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 87141 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 87142 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001
   [junit4]   2> 87142 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 87143 INFO  (Thread-168) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 87143 INFO  (Thread-168) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 87146 ERROR (Thread-168) [    ] o.a.z.s.ZooKeeperServer 
ZKShutdownHandler is not registered, so ZooKeeper server won't take any action 
on ERROR or SHUTDOWN server state changes
   [junit4]   2> 87243 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:61637
   [junit4]   2> 87256 INFO  (zkConnectionManagerCallback-211-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87262 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87262 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87263 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87263 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.Server jetty-9.4.8.v20171121, build timestamp: 
2017-11-22T08:27:37+11:00, git hash: 82b8fb23f757335bb3329d540ce37a2a2615f0a8
   [junit4]   2> 87283 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87283 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87283 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87284 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.session Scavenging every 600000ms
   [junit4]   2> 87285 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@44991d84{/solr,null,AVAILABLE}
   [junit4]   2> 87285 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@46048c79{/solr,null,AVAILABLE}
   [junit4]   2> 87285 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@6e351ee4{/solr,null,AVAILABLE}
   [junit4]   2> 87286 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@1e1d9eca{HTTP/1.1,[http/1.1]}{127.0.0.1:61656}
   [junit4]   2> 87286 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@14782c90{HTTP/1.1,[http/1.1]}{127.0.0.1:61657}
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@68cd92cd{HTTP/1.1,[http/1.1]}{127.0.0.1:61655}
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-4) [    ] 
o.e.j.s.Server Started @87584ms
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.e.j.s.Server Started @87584ms
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61656}
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61657}
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-1) [    ] 
o.e.j.s.Server Started @87584ms
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61655}
   [junit4]   2> 87287 ERROR (jetty-launcher-208-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87287 ERROR (jetty-launcher-208-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87287 ERROR (jetty-launcher-208-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.session DefaultSessionIdManager workerName=node0
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.session No SessionScavenger set, using defaults
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.session Scavenging every 660000ms
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-28T16:09:34.136Z
   [junit4]   2> 87287 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-28T16:09:34.137Z
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-28T16:09:34.137Z
   [junit4]   2> 87288 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@366a46ae{/solr,null,AVAILABLE}
   [junit4]   2> 87289 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@3a57f489{HTTP/1.1,[http/1.1]}{127.0.0.1:61658}
   [junit4]   2> 87289 INFO  (jetty-launcher-208-thread-3) [    ] 
o.e.j.s.Server Started @87586ms
   [junit4]   2> 87289 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=61658}
   [junit4]   2> 87290 ERROR (jetty-launcher-208-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 87290 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter Using logger factory 
org.apache.logging.slf4j.Log4jLoggerFactory
   [junit4]   2> 87290 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 87290 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 87290 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null
   [junit4]   2> 87290 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2018-03-28T16:09:34.139Z
   [junit4]   2> 87293 INFO  (zkConnectionManagerCallback-215-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87293 INFO  (zkConnectionManagerCallback-213-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87293 INFO  (zkConnectionManagerCallback-217-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87294 INFO  (zkConnectionManagerCallback-219-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87294 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87294 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87294 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87295 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 87307 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1004954f7b60003, likely client has closed socket
   [junit4]   2> 87310 INFO  (jetty-launcher-208-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61637/solr
   [junit4]   2> 87310 INFO  (jetty-launcher-208-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61637/solr
   [junit4]   2> 87312 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1004954f7b60002, likely client has closed socket
   [junit4]   2> 87312 INFO  (jetty-launcher-208-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61637/solr
   [junit4]   2> 87314 INFO  (zkConnectionManagerCallback-227-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87314 INFO  (zkConnectionManagerCallback-226-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87315 INFO  (zkConnectionManagerCallback-231-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87316 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1004954f7b60005, likely client has closed socket
   [junit4]   2> 87318 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn Unable to read additional data from client sessionid 
0x1004954f7b60006, likely client has closed socket
   [junit4]   2> 87321 INFO  (zkConnectionManagerCallback-233-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87321 INFO  (zkConnectionManagerCallback-235-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87322 INFO  (zkConnectionManagerCallback-237-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87355 INFO  (jetty-launcher-208-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:61637/solr
   [junit4]   2> 87367 INFO  (zkConnectionManagerCallback-244-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87373 WARN  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_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> 87373 WARN  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_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> 87373 WARN  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_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> 87389 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87390 INFO  (zkConnectionManagerCallback-246-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87390 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87390 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87391 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:61657_solr
   [junit4]   2> 87393 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61656_solr
   [junit4]   2> 87393 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61655_solr
   [junit4]   2> 87393 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.Overseer Overseer 
(id=72138223319908362-127.0.0.1:61657_solr-n_0000000000) starting
   [junit4]   2> 87406 INFO  (zkCallback-234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 87406 INFO  (zkCallback-236-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 87406 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (2)
   [junit4]   2> 87430 INFO  (zkConnectionManagerCallback-250-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 87432 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (2)
   [junit4]   2> 87434 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:61637/solr ready
   [junit4]   2> 87441 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 87441 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61657_solr
   [junit4]   2> 87445 INFO  (zkCallback-236-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 87446 INFO  (zkCallback-249-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 87464 INFO  (zkCallback-234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 87464 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (3)
   [junit4]   2> 87465 WARN  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_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> 87468 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (3)
   [junit4]   2> 87473 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 87476 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.TransientSolrCoreCacheDefault Allocating 
transient cache for 2147483647 transient cores
   [junit4]   2> 87476 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:61658_solr
   [junit4]   2> 87479 INFO  (zkCallback-236-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87479 INFO  (zkCallback-249-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87479 INFO  (zkCallback-234-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87479 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 87481 INFO  (zkCallback-245-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 88075 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61655.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88108 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61655.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88123 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61658.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88130 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61658.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88130 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61658.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88133 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node3/.
   [junit4]   2> 88137 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61655.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88138 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node1/.
   [junit4]   2> 88142 INFO  (zkConnectionManagerCallback-256-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 88144 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 88146 INFO  (zkConnectionManagerCallback-259-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 88146 INFO  (jetty-launcher-208-thread-3) 
[n:127.0.0.1:61658_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:61637/solr ready
   [junit4]   2> 88149 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 88151 INFO  (jetty-launcher-208-thread-1) 
[n:127.0.0.1:61655_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:61637/solr ready
   [junit4]   2> 88610 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61657.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88635 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61657.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88636 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61657.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88637 INFO  (jetty-launcher-208-thread-2) 
[n:127.0.0.1:61657_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node2/.
   [junit4]   2> 88885 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61656.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88908 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61656.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88908 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61656.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 88910 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node4/.
   [junit4]   2> 88920 INFO  (zkConnectionManagerCallback-263-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 88968 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (4)
   [junit4]   2> 88971 INFO  (jetty-launcher-208-thread-4) 
[n:127.0.0.1:61656_solr    ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster 
at 127.0.0.1:61637/solr ready
   [junit4]   2> 89024 INFO  (zkConnectionManagerCallback-265-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 89028 INFO  (zkConnectionManagerCallback-269-thread-1) [    ] 
o.a.s.c.c.ConnectionManager zkClient has connected
   [junit4]   2> 89030 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 89032 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:61637/solr ready
   [junit4]   2> 89047 INFO  (qtp807776368-798) [n:127.0.0.1:61658_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 89050 INFO  (OverseerThreadFactory-268-thread-1) [    ] 
o.a.s.c.a.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 89168 INFO  
(OverseerStateUpdate-72138223319908362-127.0.0.1:61657_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61655/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 89175 INFO  
(OverseerStateUpdate-72138223319908362-127.0.0.1:61657_solr-n_0000000000) [    
] 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_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61656/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 89395 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=collection1_shard2_replica_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 89395 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&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> 89397 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 89397 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 89510 INFO  (zkCallback-232-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> 89510 INFO  (zkCallback-234-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> 89510 INFO  (zkCallback-234-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> 89510 INFO  (zkCallback-232-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> 90446 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 90446 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 90473 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.IndexSchema [collection1_shard2_replica_n2] Schema name=test
   [junit4]   2> 90475 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.IndexSchema [collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 90570 WARN  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 90570 WARN  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 90570 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 90570 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard1_replica_n1' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 90570 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61655.solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 90571 WARN  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.IndexSchema Field lowerfilt1and2 is not multivalued and destination for 
multiple copyFields (2)
   [junit4]   2> 90571 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 90571 WARN  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.IndexSchema Field text is not multivalued and destination for multiple 
copyFields (3)
   [junit4]   2> 90571 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrCore [[collection1_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node1/collection1_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
   [junit4]   2> 90571 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.IndexSchema Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 90571 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.CoreContainer Creating SolrCore 'collection1_shard2_replica_n2' using 
configuration from collection collection1, trusted=true
   [junit4]   2> 90571 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_61656.solr.core.collection1.shard2.replica_n2' (registry 
'solr.core.collection1.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 90571 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 90572 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SolrCore [[collection1_shard2_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node4/collection1_shard2_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node4/./collection1_shard2_replica_n2/data/]
   [junit4]   2> 90739 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 90739 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 90751 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 90751 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 90753 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.UpdateHandler Using UpdateLog implementation: 
org.apache.solr.update.UpdateLog
   [junit4]   2> 90753 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.UpdateLog Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH 
numRecordsToKeep=100 maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 90767 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 90767 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 90857 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@45f3a202[collection1_shard2_replica_n2] main]
   [junit4]   2> 90857 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2b03bd6b[collection1_shard1_replica_n1] main]
   [junit4]   2> 90859 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 90860 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 90860 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 90860 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 90874 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1596198357785640960
   [junit4]   2> 90861 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 90877 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 90875 INFO  
(searcherExecutor-278-thread-1-processing-n:127.0.0.1:61656_solr 
x:collection1_shard2_replica_n2 c:collection1 s:shard2 r:core_node4) 
[n:127.0.0.1:61656_solr c:collection1 s:shard2 r:core_node4 
x:collection1_shard2_replica_n2] o.a.s.c.SolrCore 
[collection1_shard2_replica_n2] Registered new searcher 
Searcher@45f3a202[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 90877 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.UpdateLog Could not find max version in index or recent updates, using 
new clock 1596198357802418176
   [junit4]   2> 90878 INFO  
(searcherExecutor-277-thread-1-processing-n:127.0.0.1:61655_solr 
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node3) 
[n:127.0.0.1:61655_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[collection1_shard1_replica_n1] Registered new searcher 
Searcher@2b03bd6b[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 90883 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection1/terms/shard2 to Terms{values={core_node4=0}, version=0}
   [junit4]   2> 90884 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection1/terms/shard1 to Terms{values={core_node3=0}, version=0}
   [junit4]   2> 90888 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 90888 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 90888 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/
   [junit4]   2> 90888 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 90889 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SyncStrategy http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/ 
has no replicas
   [junit4]   2> 90889 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 90889 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 90890 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 90890 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
http://127.0.0.1:61655/solr/collection1_shard1_replica_n1/
   [junit4]   2> 90890 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync Success - now sync replicas to me
   [junit4]   2> 90890 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy http://127.0.0.1:61655/solr/collection1_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 90890 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 90895 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/ shard2
   [junit4]   2> 90896 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:61655/solr/collection1_shard1_replica_n1/ shard1
   [junit4]   2> 91003 INFO  (zkCallback-232-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> 91003 INFO  (zkCallback-234-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> 91003 INFO  (zkCallback-232-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> 91003 INFO  (zkCallback-234-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> 91012 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 91016 INFO  (qtp1247472570-786) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
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_n2&action=CREATE&numShards=2&collection=collection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1620
   [junit4]   2> 91055 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ZkController I am the leader, no recovery necessary
   [junit4]   2> 91059 INFO  (qtp984198742-791) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&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=1664
   [junit4]   2> 91064 INFO  (qtp807776368-798) [n:127.0.0.1:61658_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 91170 INFO  (zkCallback-232-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> 91170 INFO  (zkCallback-232-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> 91170 INFO  (zkCallback-234-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> 91170 INFO  (zkCallback-234-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> 92067 INFO  (qtp807776368-798) [n:127.0.0.1:61658_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf&name=collection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=3020
   [junit4]   2> 92067 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
collection1 failOnTimeout:true timeout (sec):90
   [junit4]   2> 92068 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
   [junit4]   2> 92111 INFO  
(TEST-StreamExpressionTest.testSumDifference-seed#[177EBE4810735FE8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testSumDifference
   [junit4]   2> 92130 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection1/terms/shard1 to Terms{values={core_node3=1}, version=1}
   [junit4]   2> 92130 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 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=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1596198359107895296)} 0 9
   [junit4]   2> 92135 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198359121526784,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 92135 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 92136 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198359122575360,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 92136 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 92136 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 92136 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 92136 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 92137 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 2
   [junit4]   2> 92140 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ZkShardTerms Successful update of terms at 
/collections/collection1/terms/shard2 to Terms{values={core_node4=1}, version=1}
   [junit4]   2> 92140 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
 (-1596198359101603840),commit=} 0 25
   [junit4]   2> 92149 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.S.Request [collection1_shard1_replica_n1]  webapp=/solr path=/stream 
params={indent=off&expr=sumDifference(array(2,4,6,8,10,12),array(1,2,3,4,5,6))&wt=json&version=2.2}
 status=0 QTime=4
   [junit4]   2> 92157 INFO  
(TEST-StreamExpressionTest.testSumDifference-seed#[177EBE4810735FE8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testSumDifference
   [junit4]   2> 92215 INFO  
(TEST-StreamExpressionTest.testParallelTerminatingDaemonUpdateStream-seed#[177EBE4810735FE8])
 [    ] o.a.s.SolrTestCaseJ4 ###Starting 
testParallelTerminatingDaemonUpdateStream
   [junit4]   2> 92231 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 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=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1596198359209607168)} 0 12
   [junit4]   2> 92238 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198359229530112,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 92239 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198359230578688,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 92239 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 92239 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 92239 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 92240 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 92240 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 92240 INFO  (qtp1247472570-790) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 2
   [junit4]   2> 92241 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
 (-1596198359207510016),commit=} 0 24
   [junit4]   2> 92249 INFO  (qtp807776368-810) [n:127.0.0.1:61658_solr    ] 
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params 
replicationFactor=1&collection.configName=conf&name=parallelDestinationCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2
 and sendToOCPQueue=true
   [junit4]   2> 92253 INFO  (OverseerThreadFactory-268-thread-2) [    ] 
o.a.s.c.a.c.CreateCollectionCmd Create collection parallelDestinationCollection1
   [junit4]   2> 92253 INFO  
(OverseerCollectionConfigSetProcessor-72138223319908362-127.0.0.1:61657_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 92481 INFO  
(OverseerStateUpdate-72138223319908362-127.0.0.1:61657_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"parallelDestinationCollection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"parallelDestinationCollection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61656/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 92486 INFO  
(OverseerStateUpdate-72138223319908362-127.0.0.1:61657_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"parallelDestinationCollection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"parallelDestinationCollection1_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:61657/solr";,
   [junit4]   2>   "type":"NRT",
   [junit4]   2>   "waitForFinalState":"false"} 
   [junit4]   2> 92699 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=parallelDestinationCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=parallelDestinationCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 92702 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr    ] 
o.a.s.h.a.CoreAdminOperation core create command 
qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=parallelDestinationCollection1_shard2_replica_n2&action=CREATE&numShards=2&collection=parallelDestinationCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT
   [junit4]   2> 92821 INFO  (zkCallback-232-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 92821 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 92822 INFO  (zkCallback-236-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 92822 INFO  (zkCallback-236-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 93734 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 93734 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SolrConfig Using 
Lucene MatchVersion: 8.0.0
   [junit4]   2> 93792 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.IndexSchema 
[parallelDestinationCollection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 93792 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.IndexSchema 
[parallelDestinationCollection1_shard2_replica_n2] Schema name=test
   [junit4]   2> 93857 WARN  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.IndexSchema Field 
lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 93857 WARN  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.IndexSchema Field 
text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 93858 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.IndexSchema Loaded 
schema test/1.6 with uniqueid field id
   [junit4]   2> 93860 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.CoreContainer 
Creating SolrCore 'parallelDestinationCollection1_shard2_replica_n2' using 
configuration from collection parallelDestinationCollection1, trusted=true
   [junit4]   2> 93860 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_61657.solr.core.parallelDestinationCollection1.shard2.replica_n2' 
(registry 'solr.core.parallelDestinationCollection1.shard2.replica_n2') enabled 
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 93860 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 93861 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SolrCore 
[[parallelDestinationCollection1_shard2_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node2/parallelDestinationCollection1_shard2_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node2/./parallelDestinationCollection1_shard2_replica_n2/data/]
   [junit4]   2> 93862 WARN  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.IndexSchema Field 
lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
   [junit4]   2> 93862 WARN  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.IndexSchema Field 
text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 93863 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.IndexSchema Loaded 
schema test/1.6 with uniqueid field id
   [junit4]   2> 93863 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.CoreContainer 
Creating SolrCore 'parallelDestinationCollection1_shard1_replica_n1' using 
configuration from collection parallelDestinationCollection1, trusted=true
   [junit4]   2> 93863 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.m.r.SolrJmxReporter 
JMX monitoring for 
'solr_61656.solr.core.parallelDestinationCollection1.shard1.replica_n1' 
(registry 'solr.core.parallelDestinationCollection1.shard1.replica_n1') enabled 
at server: com.sun.jmx.mbeanserver.JmxMBeanServer@77d27573
   [junit4]   2> 93863 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 93863 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SolrCore 
[[parallelDestinationCollection1_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node4/parallelDestinationCollection1_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001/tempDir-001/node4/./parallelDestinationCollection1_shard1_replica_n1/data/]
   [junit4]   2> 93946 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 93946 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 93948 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 93948 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 93949 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.u.UpdateHandler Using 
UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 93949 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 93950 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@5fd6f1e4[parallelDestinationCollection1_shard1_replica_n1] 
main]
   [junit4]   2> 93951 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.u.CommitTracker Hard 
AutoCommit: disabled
   [junit4]   2> 93951 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.u.CommitTracker Soft 
AutoCommit: disabled
   [junit4]   2> 93952 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 93953 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 93953 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.SolrIndexSearcher 
Opening [Searcher@3789b6e6[parallelDestinationCollection1_shard2_replica_n2] 
main]
   [junit4]   2> 93953 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 93954 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1596198361028886528
   [junit4]   2> 93956 INFO  
(searcherExecutor-288-thread-1-processing-n:127.0.0.1:61656_solr 
x:parallelDestinationCollection1_shard1_replica_n1 
c:parallelDestinationCollection1 s:shard1 r:core_node3) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SolrCore 
[parallelDestinationCollection1_shard1_replica_n1] Registered new searcher 
Searcher@5fd6f1e4[parallelDestinationCollection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 93957 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 93958 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 93958 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.h.ReplicationHandler 
Commits will be reserved for 10000ms.
   [junit4]   2> 93959 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.u.UpdateLog Could not 
find max version in index or recent updates, using new clock 1596198361034129408
   [junit4]   2> 93960 INFO  
(searcherExecutor-287-thread-1-processing-n:127.0.0.1:61657_solr 
x:parallelDestinationCollection1_shard2_replica_n2 
c:parallelDestinationCollection1 s:shard2 r:core_node4) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SolrCore 
[parallelDestinationCollection1_shard2_replica_n2] Registered new searcher 
Searcher@3789b6e6[parallelDestinationCollection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 93963 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/parallelDestinationCollection1/terms/shard1 to 
Terms{values={core_node3=0}, version=0}
   [junit4]   2> 93969 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.ZkShardTerms 
Successful update of terms at 
/collections/parallelDestinationCollection1/terms/shard2 to 
Terms{values={core_node4=0}, version=0}
   [junit4]   2> 93974 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 93974 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 93974 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:61656/solr/parallelDestinationCollection1_shard1_replica_n1/
   [junit4]   2> 93975 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 93975 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.SyncStrategy 
http://127.0.0.1:61656/solr/parallelDestinationCollection1_shard1_replica_n1/ 
has no replicas
   [junit4]   2> 93975 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 93981 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:61656/solr/parallelDestinationCollection1_shard1_replica_n1/ 
shard1
   [junit4]   2> 93981 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 93981 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 93982 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync 
replicas to 
http://127.0.0.1:61657/solr/parallelDestinationCollection1_shard2_replica_n2/
   [junit4]   2> 93982 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SyncStrategy Sync 
Success - now sync replicas to me
   [junit4]   2> 93982 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.SyncStrategy 
http://127.0.0.1:61657/solr/parallelDestinationCollection1_shard2_replica_n2/ 
has no replicas
   [junit4]   2> 93982 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 93990 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:61657/solr/parallelDestinationCollection1_shard2_replica_n2/ 
shard2
   [junit4]   2> 94097 INFO  (zkCallback-236-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94097 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94097 INFO  (zkCallback-236-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94097 INFO  (zkCallback-232-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94111 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 94115 INFO  (qtp1968191237-783) [n:127.0.0.1:61657_solr 
c:parallelDestinationCollection1 s:shard2 r:core_node4 
x:parallelDestinationCollection1_shard2_replica_n2] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node4&collection.configName=conf&newCollection=true&name=parallelDestinationCollection1_shard2_replica_n2&action=CREATE&numShards=2&collection=parallelDestinationCollection1&shard=shard2&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1413
   [junit4]   2> 94156 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.c.ZkController I am 
the leader, no recovery necessary
   [junit4]   2> 94159 INFO  (qtp1247472570-793) [n:127.0.0.1:61656_solr 
c:parallelDestinationCollection1 s:shard1 r:core_node3 
x:parallelDestinationCollection1_shard1_replica_n1] o.a.s.s.HttpSolrCall 
[admin] webapp=null path=/admin/cores 
params={qt=/admin/cores&coreNodeName=core_node3&collection.configName=conf&newCollection=true&name=parallelDestinationCollection1_shard1_replica_n1&action=CREATE&numShards=2&collection=parallelDestinationCollection1&shard=shard1&wt=javabin&version=2&replicaType=NRT}
 status=0 QTime=1460
   [junit4]   2> 94164 INFO  (qtp807776368-810) [n:127.0.0.1:61658_solr    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 94266 INFO  
(OverseerCollectionConfigSetProcessor-72138223319908362-127.0.0.1:61657_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000002 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 94267 INFO  (zkCallback-236-thread-3) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94267 INFO  (zkCallback-236-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94267 INFO  (zkCallback-232-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 94267 INFO  (zkCallback-232-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/parallelDestinationCollection1/state.json] for collection 
[parallelDestinationCollection1] has occurred - updating... (live nodes size: 
[4])
   [junit4]   2> 95167 INFO  (qtp807776368-810) [n:127.0.0.1:61658_solr    ] 
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections 
params={replicationFactor=1&collection.configName=conf&name=parallelDestinationCollection1&nrtReplicas=1&action=CREATE&numShards=2&wt=javabin&version=2}
 status=0 QTime=2918
   [junit4]   2> 95167 INFO  
(TEST-StreamExpressionTest.testParallelTerminatingDaemonUpdateStream-seed#[177EBE4810735FE8])
 [    ] o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - 
collection: parallelDestinationCollection1 failOnTimeout:true timeout (sec):90
   [junit4]   2> 95168 INFO  
(TEST-StreamExpressionTest.testParallelTerminatingDaemonUpdateStream-seed#[177EBE4810735FE8])
 [    ] o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: 
parallelDestinationCollection1
   [junit4]   2> 95188 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[2 
(1596198362303954944), 3 (1596198362322829312)]} 0 18
   [junit4]   2> 95192 INFO  (qtp984198742-800) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 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=[0 
(1596198362312343552), 4 (1596198362327023616), 1 (1596198362327023617)]} 0 13
   [junit4]   2> 95198 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198362333315072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 95198 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1596198362333315072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 95198 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@d272645 
commitCommandVersion:1596198362333315072
   [junit4]   2> 95201 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@5d9ca000 
commitCommandVersion:1596198362333315072
   [junit4]   2> 95273 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6448d152[collection1_shard2_replica_n2] main]
   [junit4]   2> 95275 INFO  
(searcherExecutor-278-thread-1-processing-n:127.0.0.1:61656_solr 
x:collection1_shard2_replica_n2 c:collection1 s:shard2 r:core_node4) 
[n:127.0.0.1:61656_solr c:collection1 s:shard2 r:core_node4 
x:collection1_shard2_replica_n2] o.a.s.c.SolrCore 
[collection1_shard2_replica_n2] Registered new searcher 
Searcher@6448d152[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C2)))}
   [junit4]   2> 95275 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 95275 INFO  (qtp1247472570-788) [n:127.0.0.1:61656_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:61656/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 77
   [junit4]   2> 95291 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@6fd6ae23[collection1_shard1_replica_n1] main]
   [junit4]   2> 95291 INFO  (qtp984198742-802) [n:127.0.0.1:61655_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 95293 INFO  
(searcherExecutor-277-thread-1-processing-n:127.0.0.1:61655_solr 
x:collection1_shard1_replica_n1 c:collection1 s:shard1 r:core_node3) 
[n:127.0.0.1:61655_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[collection1_shard1_replica_n1] Registered new searcher 
Searcher@6fd6ae23[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):C3)))}
   [junit4]   2>

[...truncated too long message...]

INFO  (jetty-closer-209-thread-1) [    ] o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@46048c79{/solr,null,UNAVAILABLE}
   [junit4]   2> 231439 INFO  (jetty-closer-209-thread-1) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 231448 INFO  (jetty-closer-209-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@44991d84{/solr,null,UNAVAILABLE}
   [junit4]   2> 231448 INFO  (jetty-closer-209-thread-4) [    ] 
o.e.j.s.session Stopped scavenging
   [junit4]   2> 231453 ERROR 
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.z.s.ZooKeeperServer ZKShutdownHandler is not registered, so ZooKeeper 
server won't take any action on ERROR or SHUTDOWN server state changes
   [junit4]   2> 231453 INFO  
(SUITE-StreamExpressionTest-seed#[177EBE4810735FE8]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:61637 61637
   [junit4]   2> 231522 INFO  (Thread-168) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:61637 61637
   [junit4]   2> 231835 WARN  (Thread-168) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        104     /solr/aliases.json
   [junit4]   2>        104     /solr/clusterprops.json
   [junit4]   2>        13      /solr/configs/conf
   [junit4]   2>        13      
/solr/collections/destinationCollection/terms/shard2
   [junit4]   2>        13      
/solr/collections/destinationCollection/terms/shard1
   [junit4]   2>        10      
/solr/collections/parallelDestinationCollection1/terms/shard2
   [junit4]   2>        10      
/solr/collections/parallelDestinationCollection1/terms/shard1
   [junit4]   2>        7       /solr/configs/ml
   [junit4]   2>        7       
/solr/collections/parallelDestinationCollection/terms/shard1
   [junit4]   2>        7       
/solr/collections/parallelDestinationCollection/terms/shard2
   [junit4]   2>        4       /solr/collections/workQueue1/terms/shard2
   [junit4]   2>        4       /solr/collections/workQueue1/terms/shard1
   [junit4]   2>        4       /solr/collections/mainCorpus1/terms/shard1
   [junit4]   2>        4       /solr/collections/mainCorpus1/terms/shard2
   [junit4]   2>        4       /solr/collections/modelCollection/terms/shard2
   [junit4]   2>        4       /solr/collections/modelCollection/terms/shard1
   [junit4]   2>        4       /solr/collections/destination/terms/shard2
   [junit4]   2>        4       /solr/collections/destination/terms/shard1
   [junit4]   2>        4       /solr/collections/mainCorpus/terms/shard2
   [junit4]   2>        4       /solr/security.json
   [junit4]   2>        4       /solr/collections/mainCorpus/terms/shard1
   [junit4]   2>        4       /solr/collections/uknownCollection/terms/shard1
   [junit4]   2>        4       /solr/collections/workQueue/terms/shard2
   [junit4]   2>        4       /solr/collections/workQueue/terms/shard1
   [junit4]   2>        3       /solr/collections/destination1/terms/shard1
   [junit4]   2>        3       /solr/collections/destination1/terms/shard2
   [junit4]   2>        3       
/solr/collections/checkpointCollection/terms/shard2
   [junit4]   2>        3       
/solr/collections/checkpointCollection/terms/shard1
   [junit4]   2>        3       /solr/collections/collection1/terms/shard1
   [junit4]   2>        3       /solr/collections/collection1/terms/shard2
   [junit4]   2>        3       /solr/collections/uknownCollection/terms/shard2
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        104     /solr/clusterstate.json
   [junit4]   2>        40      
/solr/collections/destinationCollection/state.json
   [junit4]   2>        26      
/solr/collections/parallelDestinationCollection1/state.json
   [junit4]   2>        20      
/solr/collections/parallelDestinationCollection/state.json
   [junit4]   2>        12      /solr/collections/collection1/state.json
   [junit4]   2>        10      /solr/collections/mainCorpus1/state.json
   [junit4]   2>        10      /solr/collections/destination/state.json
   [junit4]   2>        10      /solr/collections/destination1/state.json
   [junit4]   2>        10      /solr/collections/workQueue1/state.json
   [junit4]   2>        10      /solr/collections/workQueue/state.json
   [junit4]   2>        10      /solr/collections/uknownCollection/state.json
   [junit4]   2>        10      /solr/collections/modelCollection/state.json
   [junit4]   2>        10      
/solr/collections/checkpointCollection/state.json
   [junit4]   2>        10      /solr/collections/mainCorpus/state.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        104     /solr/live_nodes
   [junit4]   2>        104     /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_177EBE4810735FE8-001
   [junit4]   2> Mar 28, 2018 4:11:58 PM 
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
   [junit4]   2> WARNING: Will linger awaiting termination of 1 leaked 
thread(s).
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{expr_s=PostingsFormat(name=Memory), 
name_s=PostingsFormat(name=LuceneVarGapFixedInterval), terms_ss=FSTOrd50, 
join2_s=FSTOrd50, field_s=PostingsFormat(name=Direct), multiDefault=FSTOrd50, 
subject=FSTOrd50, a1_s=PostingsFormat(name=Direct), 
a2_s=PostingsFormat(name=Memory), level1_s=PostingsFormat(name=Memory), 
body_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
s_multi=PostingsFormat(name=Memory), col_s=PostingsFormat(name=Direct), 
a_ss=FSTOrd50, level2_s=PostingsFormat(name=Direct), 
a_s=PostingsFormat(name=Memory), tv_text=PostingsFormat(name=Direct), 
term_s=FSTOrd50, a_t=FSTOrd50, text_s=PostingsFormat(name=Memory), 
id=PostingsFormat(name=LuceneVarGapFixedInterval), 
text=PostingsFormat(name=Memory), featureSet_s=PostingsFormat(name=Direct), 
checkpoint_ss=PostingsFormat(name=LuceneVarGapFixedInterval), 
test_t=PostingsFormat(name=LuceneVarGapFixedInterval), 
ident_s=PostingsFormat(name=Direct), 
whitetok=PostingsFormat(name=LuceneVarGapFixedInterval), 
side_s=PostingsFormat(name=LuceneVarGapFixedInterval)}, 
docValues:{expr_s=DocValuesFormat(name=Memory), 
name_s=DocValuesFormat(name=Lucene70), 
iteration_i=DocValuesFormat(name=Lucene70), 
terms_ss=DocValuesFormat(name=Lucene70), 
join2_s=DocValuesFormat(name=Lucene70), 
field_s=DocValuesFormat(name=Asserting), 
multiDefault=DocValuesFormat(name=Lucene70), 
price_f=DocValuesFormat(name=Lucene70), a1_s=DocValuesFormat(name=Asserting), 
a_f=DocValuesFormat(name=Asserting), 
intDefault=DocValuesFormat(name=Asserting), 
join1_i=DocValuesFormat(name=Memory), 
falseNegative_i=DocValuesFormat(name=Asserting), 
a2_s=DocValuesFormat(name=Memory), a_i=DocValuesFormat(name=Lucene70), 
test_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Lucene70), 
falsePositive_i=DocValuesFormat(name=Asserting), 
field_i=DocValuesFormat(name=Lucene70), level1_s=DocValuesFormat(name=Memory), 
s_multi=DocValuesFormat(name=Memory), col_s=DocValuesFormat(name=Asserting), 
a_ss=DocValuesFormat(name=Lucene70), level2_s=DocValuesFormat(name=Asserting), 
a_s=DocValuesFormat(name=Memory), score_f=DocValuesFormat(name=Memory), 
term_s=DocValuesFormat(name=Lucene70), text_s=DocValuesFormat(name=Memory), 
id=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Lucene70), 
i_multi=DocValuesFormat(name=Lucene70), 
featureSet_s=DocValuesFormat(name=Asserting), 
trueNegative_i=DocValuesFormat(name=Memory), 
index_i=DocValuesFormat(name=Asserting), b_ls=DocValuesFormat(name=Asserting), 
test_dt=DocValuesFormat(name=Memory), out_i=DocValuesFormat(name=Asserting), 
checkpoint_ss=DocValuesFormat(name=Lucene70), 
ident_s=DocValuesFormat(name=Asserting), 
order_i=DocValuesFormat(name=Lucene70), 
_version_=DocValuesFormat(name=Asserting), 
side_s=DocValuesFormat(name=Lucene70), 
truePositive_i=DocValuesFormat(name=Memory), 
miles_i=DocValuesFormat(name=Asserting)}, maxPointsInLeafNode=1872, 
maxMBSortInHeap=5.5252421493450665, 
sim=Asserting(org.apache.lucene.search.similarities.AssertingSimilarity@7eb71734),
 locale=sq-AL, timezone=Asia/Damascus
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 1.8.0_144 
(64-bit)/cpus=3,threads=1,free=124314424,total=267386880
   [junit4]   2> NOTE: All tests run in this JVM: [AndEvaluatorTest, 
ArcTangentEvaluatorTest, SolrPingTest, LargeVolumeBinaryJettyTest, 
SquareRootEvaluatorTest, SolrExampleStreamingBinaryTest, 
SolrSchemalessExampleTest, BasicHttpSolrClientTest, JDBCStreamTest, 
RegressionEvaluatorTest, LargeVolumeEmbeddedTest, FacetFieldTest, 
StreamExpressionParserTest, NormalizeEvaluatorTest, ArcCosineEvaluatorTest, 
RoundEvaluatorTest, HttpSolrClientConPoolTest, QueryResponseTest, 
TestSuggesterResponse, CloudSolrClientCacheTest, TestV2Request, SolrParamTest, 
MergeIndexesEmbeddedTest, TestPathTrie, LBHttpSolrClientBuilderTest, 
ClientUtilsTest, OperationsTest, CubedRootEvaluatorTest, 
CorrelationEvaluatorTest, StreamExpressionTest]
   [junit4] Completed [132/147 (1!)] on J1 in 145.01s, 156 tests, 1 failure, 2 
skipped <<< FAILURES!

[...truncated 48646 lines...]
[repro] Jenkins log URL: 
https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4532/consoleText

[repro] Revision: 7260d9ce713b5f6378b97e4c64f3045eb62f98bd

[repro] Ant options: "-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC"
[repro] Repro line:  ant test  -Dtestcase=StreamExpressionTest 
-Dtests.method=testGammaDistribution -Dtests.seed=177EBE4810735FE8 
-Dtests.slow=true -Dtests.locale=sq-AL -Dtests.timezone=Asia/Damascus 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[repro] ant clean

[...truncated 6 lines...]
[repro] Test suites by module:
[repro]    solr/solrj
[repro]       StreamExpressionTest
[repro] ant compile-test

[...truncated 2467 lines...]
[repro] ant test-nocompile -Dtests.dups=5 -Dtests.maxfailures=5 
-Dtests.class="*.StreamExpressionTest" -Dtests.showOutput=onerror 
"-Dargs=-XX:-UseCompressedOops -XX:+UseG1GC" -Dtests.seed=177EBE4810735FE8 
-Dtests.slow=true -Dtests.locale=sq-AL -Dtests.timezone=Asia/Damascus 
-Dtests.asserts=true -Dtests.file.encoding=US-ASCII

[...truncated 843 lines...]
[repro] Failures:
[repro]   0/5 failed: 
org.apache.solr.client.solrj.io.stream.StreamExpressionTest
[repro] Exiting with code 0

[...truncated 70 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]

Reply via email to