Build: https://jenkins.thetaphi.de/job/Lucene-Solr-7.x-Linux/193/
Java: 32bit/jdk1.8.0_141 -client -XX:+UseConcMarkSweepGC

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

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([84A72A68018704C8:3B586BC2DF7DE454]: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.testDistributions(StreamExpressionTest.java:6037)
        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:1713)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:907)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:957)
        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:916)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:802)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:852)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
        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 14085 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
   [junit4]   2> Creating dataDir: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/init-core-data-001
   [junit4]   2> 80492 WARN  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=4 numCloses=4
   [junit4]   2> 80493 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using PointFields (NUMERIC_POINTS_SYSPROP=true) 
w/NUMERIC_DOCVALUES_SYSPROP=true
   [junit4]   2> 80494 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (true) and clientAuth (true) via: 
@org.apache.solr.util.RandomizeSSL(reason=, ssl=NaN, value=NaN, clientAuth=NaN)
   [junit4]   2> 80495 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 80495 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001
   [junit4]   2> 80495 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 80495 INFO  (Thread-276) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 80495 INFO  (Thread-276) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 80497 ERROR (Thread-276) [    ] 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> 80595 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:34241
   [junit4]   2> 80602 INFO  (jetty-launcher-260-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 80604 INFO  (jetty-launcher-260-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 80604 INFO  (jetty-launcher-260-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 80604 INFO  (jetty-launcher-260-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.14.v20161028
   [junit4]   2> 80605 INFO  (jetty-launcher-260-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@51eef7{/solr,null,AVAILABLE}
   [junit4]   2> 80606 INFO  (jetty-launcher-260-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@9f9caf{/solr,null,AVAILABLE}
   [junit4]   2> 80606 INFO  (jetty-launcher-260-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@186e9f0{/solr,null,AVAILABLE}
   [junit4]   2> 80606 INFO  (jetty-launcher-260-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@15b6d80{/solr,null,AVAILABLE}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-2) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@283f2f{SSL,[ssl, 
http/1.1]}{127.0.0.1:45351}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-1) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@fc27db{SSL,[ssl, 
http/1.1]}{127.0.0.1:37861}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-3) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@175fbf2{SSL,[ssl, 
http/1.1]}{127.0.0.1:37411}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-1) [    ] 
o.e.j.s.Server Started @81730ms
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-3) [    ] 
o.e.j.s.Server Started @81730ms
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37861}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=37411}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-2) [    ] 
o.e.j.s.Server Started @81730ms
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-4) [    ] 
o.e.j.s.AbstractConnector Started ServerConnector@1fbeb61{SSL,[ssl, 
http/1.1]}{127.0.0.1:39673}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=45351}
   [junit4]   2> 80616 INFO  (jetty-launcher-260-thread-4) [    ] 
o.e.j.s.Server Started @81731ms
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=39673}
   [junit4]   2> 80617 ERROR (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 80617 ERROR (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.1.0
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.1.0
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 80617 ERROR (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-03T09:47:45.650Z
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.1.0
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 80617 ERROR (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-03T09:47:45.650Z
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
7.1.0
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-03T09:47:45.650Z
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 80617 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-08-03T09:47:45.650Z
   [junit4]   2> 80627 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 80627 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 80628 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 80628 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 80655 INFO  (jetty-launcher-260-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34241/solr
   [junit4]   2> 80655 INFO  (jetty-launcher-260-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34241/solr
   [junit4]   2> 80659 INFO  (jetty-launcher-260-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34241/solr
   [junit4]   2> 80662 INFO  (jetty-launcher-260-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:34241/solr
   [junit4]   2> 80665 WARN  (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [    ] 
o.a.z.s.NIOServerCnxn caught end of stream exception
   [junit4]   2> EndOfStreamException: Unable to read additional data from 
client sessionid 0x15da77e67f90006, likely client has closed socket
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:239)
   [junit4]   2>        at 
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:203)
   [junit4]   2>        at java.lang.Thread.run(Thread.java:748)
   [junit4]   2> 80693 WARN  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_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> 80693 WARN  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_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> 80693 WARN  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_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> 80694 WARN  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_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> 80700 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 80700 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 80700 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 80701 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 80701 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:37411_solr
   [junit4]   2> 80702 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:39673_solr
   [junit4]   2> 80702 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37861_solr
   [junit4]   2> 80702 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:45351_solr
   [junit4]   2> 80702 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.Overseer Overseer 
(id=98418928224108553-127.0.0.1:37411_solr-n_0000000000) starting
   [junit4]   2> 80703 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 80707 INFO  
(zkCallback-279-thread-1-processing-n:127.0.0.1:45351_solr) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 80707 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 80711 INFO  
(zkCallback-282-thread-1-processing-n:127.0.0.1:39673_solr) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (0) -> (1)
   [junit4]   2> 80711 INFO  
(zkCallback-279-thread-1-processing-n:127.0.0.1:45351_solr) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 80711 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 80711 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 80712 INFO  
(zkCallback-282-thread-2-processing-n:127.0.0.1:39673_solr) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (1) -> (3)
   [junit4]   2> 80735 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:37411_solr
   [junit4]   2> 80736 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 80736 INFO  
(zkCallback-282-thread-2-processing-n:127.0.0.1:39673_solr) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 80747 INFO  
(zkCallback-279-thread-1-processing-n:127.0.0.1:45351_solr) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 80748 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (4)
   [junit4]   2> 80920 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45351.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80929 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39673.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80933 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45351.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80933 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_45351.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80935 INFO  (jetty-launcher-260-thread-2) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node2/.
   [junit4]   2> 80939 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39673.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80940 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_39673.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 80941 INFO  (jetty-launcher-260-thread-4) 
[n:127.0.0.1:39673_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node4/.
   [junit4]   2> 81066 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37861.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81066 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37411.solr.node' (registry 'solr.node') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81073 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37861.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81073 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37861.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81081 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37411.solr.jvm' (registry 'solr.jvm') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81081 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37411.solr.jetty' (registry 'solr.jetty') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 81082 INFO  (jetty-launcher-260-thread-1) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node1/.
   [junit4]   2> 81083 INFO  (jetty-launcher-260-thread-3) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.CorePropertiesLocator Found 0 core 
definitions underneath 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node3/.
   [junit4]   2> 81177 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 81177 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34241/solr ready
   [junit4]   2> 81266 INFO  (qtp16370626-1167) [n:127.0.0.1:39673_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> 81267 INFO  
(OverseerThreadFactory-396-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.CreateCollectionCmd Create collection 
collection1
   [junit4]   2> 81373 INFO  
(OverseerStateUpdate-98418928224108553-127.0.0.1:37411_solr-n_0000000000) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37861/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 81375 INFO  
(OverseerStateUpdate-98418928224108553-127.0.0.1:37411_solr-n_0000000000) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"collection1_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"https://127.0.0.1:37411/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 81645 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 81645 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 81650 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 81651 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 81754 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 81754 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 81754 INFO  
(zkCallback-281-thread-2-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 81754 INFO  
(zkCallback-280-thread-2-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 82691 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 82691 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SolrConfig Using Lucene MatchVersion: 7.1.0
   [junit4]   2> 82747 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 82747 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83040 WARN  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83040 WARN  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83041 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83041 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83042 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37861.solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 83042 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 83042 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node1/collection1_shard1_replica_n1],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node1/./collection1_shard1_replica_n1/data/]
   [junit4]   2> 83043 WARN  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83043 WARN  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83045 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83046 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83046 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_37411.solr.core.collection1.shard2.replica_n2' (registry 
'solr.core.collection1.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@14c51ed
   [junit4]   2> 83047 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SolrCore solr.RecoveryStrategy.Builder
   [junit4]   2> 83047 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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 
[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node3/collection1_shard2_replica_n2],
 
dataDir=[/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001/tempDir-001/node3/./collection1_shard2_replica_n2/data/]
   [junit4]   2> 83187 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83187 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83188 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83188 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83204 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 83204 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 83205 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Hard AutoCommit: disabled
   [junit4]   2> 83205 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.CommitTracker Soft AutoCommit: disabled
   [junit4]   2> 83206 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@11a43e0[collection1_shard2_replica_n2] main]
   [junit4]   2> 83207 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@e25b11[collection1_shard1_replica_n1] main]
   [junit4]   2> 83207 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83208 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83208 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83208 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83208 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 83209 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.h.ReplicationHandler Commits will be reserved for  10000
   [junit4]   2> 83210 INFO  
(searcherExecutor-406-thread-1-processing-n:127.0.0.1:37411_solr 
x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) 
[n:127.0.0.1:37411_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@11a43e0[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 83210 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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 1574702854431571968
   [junit4]   2> 83211 INFO  
(searcherExecutor-405-thread-1-processing-n:127.0.0.1:37861_solr 
x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) 
[n:127.0.0.1:37861_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@e25b11[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 83211 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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 1574702854432620544
   [junit4]   2> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/
   [junit4]   2> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy Sync replicas to 
https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/
   [junit4]   2> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/ has no replicas
   [junit4]   2> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.SyncStrategy 
https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/ has no replicas
   [junit4]   2> 83221 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83221 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83224 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/ shard2
   [junit4]   2> 83225 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/ shard1
   [junit4]   2> 83327 INFO  
(zkCallback-280-thread-2-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 83327 INFO  
(zkCallback-281-thread-2-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 83327 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 83327 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 83375 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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> 83375 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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> 83377 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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=1732
   [junit4]   2> 83377 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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=1726
   [junit4]   2> 83382 INFO  (qtp16370626-1167) [n:127.0.0.1:39673_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> 83481 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 83481 INFO  
(zkCallback-280-thread-2-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 83481 INFO  
(zkCallback-280-thread-1-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] 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> 83481 INFO  
(zkCallback-281-thread-2-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] 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> 84383 INFO  (qtp16370626-1167) [n:127.0.0.1:39673_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=3117
   [junit4]   2> 84384 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
collection1 failOnTimeout:true timeout (sec):90
   [junit4]   2> 84384 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
   [junit4]   2> 84401 INFO  
(TEST-StreamExpressionTest.testParallelHavingStream-seed#[84A72A68018704C8]) [  
  ] o.a.s.SolrTestCaseJ4 ###Starting testParallelHavingStream
   [junit4]   2> 84423 INFO  (qtp30217416-1173) [n:127.0.0.1:37411_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=TOLEADER&distrib.from=https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1574702855700348928)} 0 3
   [junit4]   2> 84427 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855707688960,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84427 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_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> 84428 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84428 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_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=https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 84430 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855710834688,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84430 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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> 84431 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84431 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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=https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 84431 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
 (-1574702855686717440),commit=} 0 24
   [junit4]   2> 84438 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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 
(1574702855716077568), 4 (1574702855718174720), 1 (1574702855718174721), 8 
(1574702855719223296)]} 0 3
   [junit4]   2> 84441 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_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 
(1574702855718174720), 3 (1574702855720271872), 5 (1574702855720271873), 6 
(1574702855721320448), 7 (1574702855721320449), 9 (1574702855721320450)]} 0 3
   [junit4]   2> 84444 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855725514752,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84444 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855725514752,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84444 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_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@375b30 
commitCommandVersion:1574702855725514752
   [junit4]   2> 84444 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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@194fbec 
commitCommandVersion:1574702855725514752
   [junit4]   2> 84456 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@15e061[collection1_shard2_replica_n2] main]
   [junit4]   2> 84456 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84459 INFO  
(searcherExecutor-406-thread-1-processing-n:127.0.0.1:37411_solr 
x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) 
[n:127.0.0.1:37411_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@15e061[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C6)))}
   [junit4]   2> 84460 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_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=https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 15
   [junit4]   2> 84462 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@d068cf[collection1_shard1_replica_n1] main]
   [junit4]   2> 84462 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84463 INFO  
(searcherExecutor-405-thread-1-processing-n:127.0.0.1:37861_solr 
x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) 
[n:127.0.0.1:37861_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@d068cf[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.1.0):C4)))}
   [junit4]   2> 84463 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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=https://127.0.0.1:37861/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 19
   [junit4]   2> 84464 INFO  (qtp30585454-1166) [n:127.0.0.1:37861_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&commit=true&wt=javabin&version=2}{commit=} 0 22
   [junit4]   2> 84469 INFO  
(TEST-StreamExpressionTest.testParallelHavingStream-seed#[84A72A68018704C8]) [  
  ] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 84470 INFO  
(TEST-StreamExpressionTest.testParallelHavingStream-seed#[84A72A68018704C8]) [  
  ] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34241/solr 
ready
   [junit4]   2> 84476 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),eq(a_i,val(9)))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84479 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),eq(a_i,val(9)))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84482 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 84483 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34241/solr ready
   [junit4]   2> 84492 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=3
   [junit4]   2> 84492 INFO  (qtp30585454-1170) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=3 status=0 QTime=4
   [junit4]   2> 84495 INFO  (qtp30217416-1173) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=6
   [junit4]   2> 84495 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=1 status=0 QTime=7
   [junit4]   2> 84507 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(eq(a_i,val(9)),lt(a_i,val(10))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84507 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(eq(a_i,val(9)),lt(a_i,val(10))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84514 INFO  (qtp30585454-1183) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 84514 INFO  (qtp30217416-1176) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 84515 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=1 status=0 QTime=0
   [junit4]   2> 84515 INFO  (qtp30217416-1303) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84528 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),or(eq(a_i,val(9)),eq(a_i,val(8))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84529 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),or(eq(a_i,val(9)),eq(a_i,val(8))))&wt=json&version=2.2}
 status=0 QTime=1
   [junit4]   2> 84532 INFO  (qtp30585454-1170) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 84533 INFO  (qtp30217416-1181) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 84533 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=1 status=0 QTime=0
   [junit4]   2> 84533 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84544 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(eq(a_i,val(9)),not(eq(a_i,val(9)))))&wt=json&version=2.2}
 status=0 QTime=3
   [junit4]   2> 84545 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(eq(a_i,val(9)),not(eq(a_i,val(9)))))&wt=json&version=2.2}
 status=0 QTime=3
   [junit4]   2> 84549 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=1 status=0 QTime=0
   [junit4]   2> 84549 INFO  (qtp30217416-1181) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84549 INFO  (qtp30217416-1173) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 84551 INFO  (qtp30585454-1162) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 84557 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(lteq(a_i,val(9)),gteq(a_i,val(8))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84558 INFO  (qtp30217416-1176) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Did,zkHost%3D"127.0.0.1:34241/solr"),and(lteq(a_i,val(9)),gteq(a_i,val(8))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84564 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=3 status=0 QTime=1
   [junit4]   2> 84564 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84566 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=1 status=0 QTime=0
   [junit4]   2> 84567 INFO  (qtp30217416-1181) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=id&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 84576 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=having(rollup(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Da_f,zkHost%3D"127.0.0.1:34241/solr"),over%3Da_f,sum(a_i)),and(eq(sum(a_i),val(9)),eq(sum(a_i),val(9))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84576 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=having(rollup(search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_f+asc",partitionKeys%3Da_f,zkHost%3D"127.0.0.1:34241/solr"),over%3Da_f,sum(a_i)),and(eq(sum(a_i),val(9)),eq(sum(a_i),val(9))))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84586 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=a_f&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=0 status=0 QTime=1
   [junit4]   2> 84586 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=a_f&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=6 status=0 QTime=2
   [junit4]   2> 84586 INFO  (qtp30585454-1183) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=a_f&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=4 status=0 QTime=2
   [junit4]   2> 84586 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc&partitionKeys=a_f&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 84590 INFO  
(TEST-StreamExpressionTest.testParallelHavingStream-seed#[84A72A68018704C8]) [  
  ] o.a.s.SolrTestCaseJ4 ###Ending testParallelHavingStream
   [junit4]   2> 84607 INFO  
(TEST-StreamExpressionTest.testParallelRankStream-seed#[84A72A68018704C8]) [    
] o.a.s.SolrTestCaseJ4 ###Starting testParallelRankStream
   [junit4]   2> 84612 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@dc7289[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 84615 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1615a58[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 84616 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1574702855903772672)} 0 2
   [junit4]   2> 84618 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855907966976,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84619 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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@194fbec 
commitCommandVersion:1574702855907966976
   [junit4]   2> 84623 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@109bd61[collection1_shard1_replica_n1] main]
   [junit4]   2> 84623 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84625 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855915307008,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84625 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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@375b30 
commitCommandVersion:1574702855915307008
   [junit4]   2> 84626 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@132753c[collection1_shard2_replica_n2] main]
   [junit4]   2> 84626 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84626 INFO  
(searcherExecutor-405-thread-1-processing-n:127.0.0.1:37861_solr 
x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) 
[n:127.0.0.1:37861_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@109bd61[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 84627 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 8
   [junit4]   2> 84629 INFO  
(searcherExecutor-406-thread-1-processing-n:127.0.0.1:37411_solr 
x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) 
[n:127.0.0.1:37411_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@132753c[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 84630 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 5
   [junit4]   2> 84631 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_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=*:*
 (-1574702855899578368),commit=} 0 22
   [junit4]   2> 84636 INFO  (qtp30585454-1164) [n:127.0.0.1:37861_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 
(1574702855923695616), 4 (1574702855925792768), 8 (1574702855925792769), 10 
(1574702855926841344)]} 0 3
   [junit4]   2> 84636 INFO  (qtp30217416-1181) [n:127.0.0.1:37411_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 
(1574702855923695616), 3 (1574702855925792768), 5 (1574702855925792769), 6 
(1574702855926841344), 7 (1574702855926841345), 9 (1574702855926841346)]} 0 3
   [junit4]   2> 84639 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855929987072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84639 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702855929987072,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84639 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_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@375b30 
commitCommandVersion:1574702855929987072
   [junit4]   2> 84640 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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@194fbec 
commitCommandVersion:1574702855929987072
   [junit4]   2> 84651 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4b6d92[collection1_shard2_replica_n2] main]
   [junit4]   2> 84652 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84653 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@3dcd0[collection1_shard1_replica_n1] main]
   [junit4]   2> 84657 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84658 INFO  
(searcherExecutor-406-thread-1-processing-n:127.0.0.1:37411_solr 
x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) 
[n:127.0.0.1:37411_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@4b6d92[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C6)))}
   [junit4]   2> 84658 INFO  (qtp30217416-1175) [n:127.0.0.1:37411_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 19
   [junit4]   2> 84659 INFO  
(searcherExecutor-405-thread-1-processing-n:127.0.0.1:37861_solr 
x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) 
[n:127.0.0.1:37861_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@3dcd0[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.1.0):C4)))}
   [junit4]   2> 84659 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 20
   [junit4]   2> 84661 INFO  (qtp30217416-1173) [n:127.0.0.1:37411_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}{commit=} 0 23
   [junit4]   2> 84664 INFO  
(TEST-StreamExpressionTest.testParallelRankStream-seed#[84A72A68018704C8]) [    
] o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 84665 INFO  
(TEST-StreamExpressionTest.testParallelRankStream-seed#[84A72A68018704C8]) [    
] o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:34241/solr ready
   [junit4]   2> 84674 INFO  (qtp30217416-1181) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={distrib=false&workerID=0&indent=off&numWorkers=2&expr=top(n%3D11,search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i",sort%3D"a_i+asc",partitionKeys%3Da_i,zkHost%3D"127.0.0.1:34241/solr"),sort%3D"a_i+desc")&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84676 INFO  (qtp30585454-1187) [n:127.0.0.1:37861_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={distrib=false&workerID=1&indent=off&numWorkers=2&expr=top(n%3D11,search(collection1,q%3D"*:*",fl%3D"id,a_s,a_i",sort%3D"a_i+asc",partitionKeys%3Da_i,zkHost%3D"127.0.0.1:34241/solr"),sort%3D"a_i+desc")&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 84684 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84685 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=4 status=0 QTime=0
   [junit4]   2> 84685 INFO  (qtp30217416-1303) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.c.S.Request [collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D2+worker%3D0}&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 84688 INFO  (qtp30585454-1302) [n:127.0.0.1:37861_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=/select 
params={q=*:*&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D2+worker%3D1}&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 84690 INFO  
(TEST-StreamExpressionTest.testParallelRankStream-seed#[84A72A68018704C8]) [    
] o.a.s.SolrTestCaseJ4 ###Ending testParallelRankStream
   [junit4]   2> 84709 INFO  
(TEST-StreamExpressionTest.testCopyOfRange-seed#[84A72A68018704C8]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testCopyOfRange
   [junit4]   2> 84712 INFO  (qtp30217416-1303) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@f003ed[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 84713 INFO  (qtp30585454-1183) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@295d3[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 84713 INFO  (qtp30585454-1183) [n:127.0.0.1:37861_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1574702856006533120)} 0 1
   [junit4]   2> 84715 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702856009678848,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84715 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702856009678848,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84715 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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@194fbec 
commitCommandVersion:1574702856009678848
   [junit4]   2> 84715 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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@375b30 
commitCommandVersion:1574702856009678848
   [junit4]   2> 84715 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@10d01e4[collection1_shard1_replica_n1] main]
   [junit4]   2> 84715 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@19bdc16[collection1_shard2_replica_n2] main]
   [junit4]   2> 84716 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84716 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_solr 
c:collection1 s:shard1 r:core_node3 x:collection1_shard1_replica_n1] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 84718 INFO  
(searcherExecutor-405-thread-1-processing-n:127.0.0.1:37861_solr 
x:collection1_shard1_replica_n1 s:shard1 c:collection1 r:core_node3) 
[n:127.0.0.1:37861_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@10d01e4[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 84719 INFO  (qtp30585454-1191) [n:127.0.0.1:37861_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 3
   [junit4]   2> 84730 INFO  
(searcherExecutor-406-thread-1-processing-n:127.0.0.1:37411_solr 
x:collection1_shard2_replica_n2 s:shard2 c:collection1 r:core_node4) 
[n:127.0.0.1:37411_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@19bdc16[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 84731 INFO  (qtp30217416-1168) [n:127.0.0.1:37411_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=https://127.0.0.1:37411/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 16
   [junit4]   2> 84732 INFO  (qtp30217416-1303) [n:127.0.0.1:37411_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=*:*
 (-1574702856005484544),commit=} 0 21
   [junit4]   2> 84777 INFO  (qtp30217416-1189) [n:127.0.0.1:37411_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=[id_1 
(1574702856031698944), id_3 (1574702856032747520), id_4 (1574702856033796096), 
id_5 (1574702856033796097), id_6 (1574702856033796098), id_7 
(1574702856034844672), id_8 (1574702856034844673), id_9 (1574702856034844674), 
id_11 (1574702856035893248), id_12 (1574702856035893249), ... (125 adds)]} 0 42
   [junit4]   2> 84778 INFO  (qtp30585454-1166) [n:127.0.0.1:37861_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=[id_2 
(1574702856031698944), id_10 (1574702856033796096), id_13 
(1574702856033796097), id_14 (1574702856034844672), id_16 
(1574702856034844673), id_17 (1574702856034844674), id_18 
(1574702856035893248), id_21 (1574702856035893249), id_22 
(1574702856035893250), id_23 (1574702856035893251), ... (125 adds)]} 0 41
   [junit4]   2> 84781 INFO  (qtp30217416-1185) [n:127.0.0.1:37411_solr 
c:collection1 s:shard2 r:core_node4 x:collection1_shard2_replica_n2] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1574702856078884864,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 84781 INFO  (qtp30585454-1187) [n:127.0.

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

processing-n:127.0.0.1:37411_solr) [n:127.0.0.1:37411_solr    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (4) -> (2)
   [junit4]   2> 194359 INFO  (jetty-closer-261-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@15b6d80{/solr,null,UNAVAILABLE}
   [junit4]   2> 194360 INFO  (coreCloseExecutor-598-thread-1) 
[n:127.0.0.1:37861_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.c.SolrCore 
[collection1_shard1_replica_n1]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@1d48338
   [junit4]   2> 194361 INFO  (coreCloseExecutor-598-thread-1) 
[n:127.0.0.1:37861_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.core.collection1.shard1.replica_n1, tag=30704440
   [junit4]   2> 194366 INFO  (coreCloseExecutor-595-thread-1) 
[n:127.0.0.1:37411_solr c:collection1 s:shard2 r:core_node4 
x:collection1_shard2_replica_n2] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard2.leader, tag=20342061
   [junit4]   2> 194371 INFO  (jetty-closer-261-thread-4) [    ] 
o.a.s.c.Overseer Overseer 
(id=98418928224108553-127.0.0.1:37411_solr-n_0000000000) closing
   [junit4]   2> 194372 INFO  
(OverseerStateUpdate-98418928224108553-127.0.0.1:37411_solr-n_0000000000) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.Overseer Overseer Loop exiting : 
127.0.0.1:37411_solr
   [junit4]   2> 194372 INFO  (coreCloseExecutor-598-thread-1) 
[n:127.0.0.1:37861_solr c:collection1 s:shard1 r:core_node3 
x:collection1_shard1_replica_n1] o.a.s.m.SolrMetricManager Closing metric 
reporters for registry=solr.collection.collection1.shard1.leader, tag=30704440
   [junit4]   2> 194373 WARN  
(zkCallback-280-thread-2-processing-n:127.0.0.1:37411_solr) 
[n:127.0.0.1:37411_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 194373 INFO  
(zkCallback-281-thread-2-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.OverseerElectionContext I am going to be 
the leader 127.0.0.1:37861_solr
   [junit4]   2> 194373 INFO  (jetty-closer-261-thread-4) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@51eef7{/solr,null,UNAVAILABLE}
   [junit4]   2> 194373 INFO  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (2) -> (1)
   [junit4]   2> 194374 WARN  
(zkCallback-281-thread-1-processing-n:127.0.0.1:37861_solr) 
[n:127.0.0.1:37861_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 195857 WARN  
(zkCallback-279-thread-2-processing-n:127.0.0.1:45351_solr) 
[n:127.0.0.1:45351_solr    ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, 
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 195858 INFO  (jetty-closer-261-thread-1) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@186e9f0{/solr,null,UNAVAILABLE}
   [junit4]   2> 195874 INFO  (jetty-closer-261-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@9f9caf{/solr,null,UNAVAILABLE}
   [junit4]   2> 195875 ERROR 
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-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> 195875 INFO  
(SUITE-StreamExpressionTest-seed#[84A72A68018704C8]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:34241 34241
   [junit4]   2> 197035 INFO  (Thread-276) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:34241 34241
   [junit4]   2> 197037 WARN  (Thread-276) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        91      /solr/aliases.json
   [junit4]   2>        13      /solr/configs/conf
   [junit4]   2>        7       /solr/configs/ml
   [junit4]   2>        4       /solr/security.json
   [junit4]   2> 
   [junit4]   2> Maximum concurrent data watches above limit:
   [junit4]   2> 
   [junit4]   2>        91      /solr/clusterprops.json
   [junit4]   2>        91      /solr/clusterstate.json
   [junit4]   2>        38      
/solr/collections/destinationCollection/state.json
   [junit4]   2>        26      
/solr/collections/parallelDestinationCollection1/state.json
   [junit4]   2>        20      /solr/collections/destination/state.json
   [junit4]   2>        20      
/solr/collections/parallelDestinationCollection/state.json
   [junit4]   2>        20      /solr/collections/mainCorpus/state.json
   [junit4]   2>        18      /solr/collections/workQueue/state.json
   [junit4]   2>        10      /solr/collections/collection1/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>        2       
/solr/overseer_elect/election/98418928224108553-127.0.0.1:37411_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        91      /solr/live_nodes
   [junit4]   2>        91      /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/home/jenkins/workspace/Lucene-Solr-7.x-Linux/solr/build/solr-solrj/test/J0/temp/solr.client.solrj.io.stream.StreamExpressionTest_84A72A68018704C8-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{name_s=PostingsFormat(name=Memory), expr_s=PostingsFormat(name=Direct), 
terms_ss=PostingsFormat(name=MockRandom), 
join2_s=PostingsFormat(name=MockRandom), field_s=Lucene50(blocksize=128), 
multiDefault=PostingsFormat(name=MockRandom), 
subject=PostingsFormat(name=MockRandom), a1_s=PostingsFormat(name=MockRandom), 
a2_s=PostingsFormat(name=Memory), level1_s=PostingsFormat(name=Direct), 
body_t=PostingsFormat(name=Memory), s_multi=PostingsFormat(name=Memory), 
col_s=PostingsFormat(name=MockRandom), level2_s=Lucene50(blocksize=128), 
a_ss=Lucene50(blocksize=128), a_s=PostingsFormat(name=Memory), 
tv_text=Lucene50(blocksize=128), term_s=PostingsFormat(name=MockRandom), 
a_t=Lucene50(blocksize=128), text_s=PostingsFormat(name=Direct), 
id=PostingsFormat(name=Direct), text=PostingsFormat(name=Memory), 
featureSet_s=PostingsFormat(name=MockRandom), 
checkpoint_ss=PostingsFormat(name=Memory), test_t=PostingsFormat(name=Memory), 
ident_s=PostingsFormat(name=MockRandom), whitetok=PostingsFormat(name=Memory), 
side_s=PostingsFormat(name=Memory)}, 
docValues:{name_s=DocValuesFormat(name=Memory), 
expr_s=DocValuesFormat(name=Lucene70), 
iteration_i=DocValuesFormat(name=Lucene70), 
terms_ss=DocValuesFormat(name=Direct), join2_s=DocValuesFormat(name=Direct), 
multiDefault=DocValuesFormat(name=Direct), a_f=DocValuesFormat(name=Direct), 
intDefault=DocValuesFormat(name=Lucene70), 
falseNegative_i=DocValuesFormat(name=Lucene70), 
a2_s=DocValuesFormat(name=Memory), a_i=DocValuesFormat(name=Lucene70), 
level1_s=DocValuesFormat(name=Lucene70), a_s=DocValuesFormat(name=Memory), 
id=DocValuesFormat(name=Lucene70), alpha_d=DocValuesFormat(name=Memory), 
i_multi=DocValuesFormat(name=Lucene70), idf_d=DocValuesFormat(name=Direct), 
b_ls=DocValuesFormat(name=Direct), checkpoint_ss=DocValuesFormat(name=Memory), 
ident_s=DocValuesFormat(name=Direct), order_i=DocValuesFormat(name=Direct), 
error_d=DocValuesFormat(name=Lucene70), side_s=DocValuesFormat(name=Memory), 
truePositive_i=DocValuesFormat(name=Lucene70), 
miles_i=DocValuesFormat(name=Direct), field_s=DocValuesFormat(name=Lucene70), 
price_f=DocValuesFormat(name=Direct), a1_s=DocValuesFormat(name=Direct), 
join1_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Memory), 
test_i=DocValuesFormat(name=Direct), 
falsePositive_i=DocValuesFormat(name=Lucene70), 
field_i=DocValuesFormat(name=Direct), s_multi=DocValuesFormat(name=Memory), 
col_s=DocValuesFormat(name=Direct), level2_s=DocValuesFormat(name=Lucene70), 
a_ss=DocValuesFormat(name=Lucene70), score_f=DocValuesFormat(name=Memory), 
term_s=DocValuesFormat(name=Direct), text_s=DocValuesFormat(name=Lucene70), 
timestamp=DocValuesFormat(name=Lucene70), 
idfs_ds=DocValuesFormat(name=Lucene70), 
weights_ds=DocValuesFormat(name=Memory), 
featureSet_s=DocValuesFormat(name=Direct), 
trueNegative_i=DocValuesFormat(name=Memory), 
index_i=DocValuesFormat(name=Direct), test_dt=DocValuesFormat(name=Lucene70), 
out_i=DocValuesFormat(name=Direct), _version_=DocValuesFormat(name=Lucene70)}, 
maxPointsInLeafNode=684, maxMBSortInHeap=5.419466197633144, 
sim=RandomSimilarity(queryNorm=false): {}, locale=en-CA, 
timezone=America/Indiana/Knox
   [junit4]   2> NOTE: Linux 4.10.0-27-generic i386/Oracle Corporation 
1.8.0_141 (32-bit)/cpus=8,threads=1,free=198773432,total=358195200
   [junit4]   2> NOTE: All tests run in this JVM: [TestSuggesterResponse, 
TestLBHttpSolrClient, TestValidatingJsonMap, TestEmbeddedSolrServer, 
CompoundEvaluatorTest, CloudSolrClientMultiConstructorTest, 
SolrExampleStreamingTest, ContentStreamTest, RoundEvaluatorTest, 
SubtractEvaluatorTest, AbsoluteValueEvaluatorTest, MultiplyEvaluatorTest, 
LargeVolumeBinaryJettyTest, GreaterThanEqualToEvaluatorTest, 
TestNamedListCodec, BasicHttpSolrClientTest, ConcurrentUpdateSolrClientTest, 
CommonParamsTest, AnlysisResponseBaseTest, StreamExpressionToExpessionTest, 
ArrayEvaluatorTest, SolrExampleEmbeddedTest, LargeVolumeEmbeddedTest, 
QueryResponseTest, TestHash, ModifiableSolrParamsTest, TestFastInputStream, 
TestXMLEscaping, SolrDocumentTest, SolrExceptionTest, TestUpdateRequestCodec, 
FieldAnalysisResponseTest, NamedListTest, SolrSchemalessExampleTest, 
ConcurrentUpdateSolrClientBuilderTest, HttpSolrClientSSLAuthConPoolTest, 
GraphExpressionTest, GraphTest, StreamExpressionTest]
   [junit4] Completed [135/135 (1!)] on J0 in 116.60s, 93 tests, 1 failure <<< 
FAILURES!

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

Reply via email to