Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-MacOSX/4192/
Java: 64bit/jdk-9 -XX:+UseCompressedOops -XX:+UseG1GC --illegal-access=deny

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

Error Message:


Stack Trace:
java.lang.AssertionError
        at 
__randomizedtesting.SeedInfo.seed([EBF4AA0B094B04EA:540BEBA1D7B1E476]: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:6110)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
        at 
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
        at 
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
        at java.base/java.lang.reflect.Method.invoke(Method.java:564)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1737)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:934)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:970)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:984)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:49)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:817)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:468)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:943)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:829)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:879)
        at 
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:890)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
        at 
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
        at 
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
        at 
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
        at 
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
        at 
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
        at 
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:368)
        at java.base/java.lang.Thread.run(Thread.java:844)




Build Log:
[...truncated 14697 lines...]
   [junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamExpressionTest
   [junit4]   2> Creating dataDir: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/init-core-data-001
   [junit4]   2> 101123 WARN  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 startTrackingSearchers: numOpens=63 numCloses=63
   [junit4]   2> 101123 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Using TrieFields (NUMERIC_POINTS_SYSPROP=false) 
w/NUMERIC_DOCVALUES_SYSPROP=false
   [junit4]   2> 101123 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (false) via: 
@org.apache.solr.util.RandomizeSSL(reason="", value=0.0/0.0, ssl=0.0/0.0, 
clientAuth=0.0/0.0) w/ MAC_OS_X supressed clientAuth
   [junit4]   2> 101123 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.SolrTestCaseJ4 SecureRandom sanity checks: 
test.solr.allowed.securerandom=null & java.security.egd=file:/dev/./urandom
   [junit4]   2> 101124 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.MiniSolrCloudCluster Starting cluster of 4 servers in 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001
   [junit4]   2> 101124 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
   [junit4]   2> 101124 INFO  (Thread-312) [    ] o.a.s.c.ZkTestServer client 
port:0.0.0.0/0.0.0.0:0
   [junit4]   2> 101124 INFO  (Thread-312) [    ] o.a.s.c.ZkTestServer Starting 
server
   [junit4]   2> 101127 ERROR (Thread-312) [    ] 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> 101230 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.ZkTestServer start zk server on port:58986
   [junit4]   2> 101244 INFO  (jetty-launcher-237-thread-1) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 101245 INFO  (jetty-launcher-237-thread-2) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 101245 INFO  (jetty-launcher-237-thread-3) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 101246 INFO  (jetty-launcher-237-thread-4) [    ] 
o.e.j.s.Server jetty-9.3.20.v20170531
   [junit4]   2> 101247 INFO  (jetty-launcher-237-thread-3) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@7a4e18b2{/solr,null,AVAILABLE}
   [junit4]   2> 101248 INFO  (jetty-launcher-237-thread-3) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@553bcf81{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 101248 INFO  (jetty-launcher-237-thread-3) [    ] 
o.e.j.s.Server Started @??????ms
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=58988}
   [junit4]   2> 101249 ERROR (jetty-launcher-237-thread-3) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-28T00:46:11.522435Z
   [junit4]   2> 101249 INFO  (jetty-launcher-237-thread-2) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@28ff8783{/solr,null,AVAILABLE}
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@eef0d13{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.e.j.s.Server Started @??????ms
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=58989}
   [junit4]   2> 101250 ERROR (jetty-launcher-237-thread-2) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 101250 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-28T00:46:11.523768Z
   [junit4]   2> 101251 INFO  (jetty-launcher-237-thread-4) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@a171650{/solr,null,AVAILABLE}
   [junit4]   2> 101251 INFO  (jetty-launcher-237-thread-4) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@5e541f28{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 101251 INFO  (jetty-launcher-237-thread-4) [    ] 
o.e.j.s.Server Started @??????ms
   [junit4]   2> 101251 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=58990}
   [junit4]   2> 101251 ERROR (jetty-launcher-237-thread-4) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 101251 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 101252 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 101252 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 101252 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-28T00:46:11.525077Z
   [junit4]   2> 101253 INFO  (jetty-launcher-237-thread-1) [    ] 
o.e.j.s.h.ContextHandler Started 
o.e.j.s.ServletContextHandler@40c77b94{/solr,null,AVAILABLE}
   [junit4]   2> 101254 INFO  (jetty-launcher-237-thread-1) [    ] 
o.e.j.s.AbstractConnector Started 
ServerConnector@18c04b8e{HTTP/1.1,[http/1.1]}{127.0.0.1:?????}
   [junit4]   2> 101254 INFO  (jetty-launcher-237-thread-1) [    ] 
o.e.j.s.Server Started @??????ms
   [junit4]   2> 101254 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr, 
hostPort=58992}
   [junit4]   2> 101254 ERROR (jetty-launcher-237-thread-1) [    ] 
o.a.s.u.StartupLoggingUtils Missing Java Option solr.log.dir. Logging may be 
missing or incomplete.
   [junit4]   2> 101255 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter  ___      _       Welcome to Apache Solr? version 
8.0.0
   [junit4]   2> 101255 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter / __| ___| |_ _   Starting in cloud mode on port null
   [junit4]   2> 101255 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_|  Install dir: null, Default config 
dir: null
   [junit4]   2> 101255 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter |___/\___/_|_|    Start time: 
2017-09-28T00:46:11.528279Z
   [junit4]   2> 101262 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 101262 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 101263 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 101266 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
   [junit4]   2> 101273 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58986/solr
   [junit4]   2> 101276 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58986/solr
   [junit4]   2> 101277 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58986/solr
   [junit4]   2> 101279 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:58986/solr
   [junit4]   2> 101320 WARN  (jetty-launcher-237-thread-2) [    ] 
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> 101321 WARN  (jetty-launcher-237-thread-1) [    ] 
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> 101322 WARN  (jetty-launcher-237-thread-4) [    ] 
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> 101323 WARN  (jetty-launcher-237-thread-3) [    ] 
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> 101331 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 101331 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 101331 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 101331 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.c.Overseer Overseer (id=null) closing
   [junit4]   2> 101332 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.OverseerElectionContext I am going to be the leader 127.0.0.1:58989_solr
   [junit4]   2> 101333 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58990_solr
   [junit4]   2> 101333 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58992_solr
   [junit4]   2> 101333 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58988_solr
   [junit4]   2> 101334 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=98733888071204874-127.0.0.1:58989_solr-n_0000000000) starting
   [junit4]   2> 101335 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 101335 INFO  (zkCallback-258-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 101336 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 101336 INFO  (zkCallback-259-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
   [junit4]   2> 101337 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 101337 INFO  (zkCallback-258-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 101337 INFO  (zkCallback-259-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 101337 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (1) -> (3)
   [junit4]   2> 101364 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.ZkController Register node as live in 
ZooKeeper:/live_nodes/127.0.0.1:58989_solr
   [junit4]   2> 101368 INFO  (zkCallback-259-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 101368 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 101368 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 101379 INFO  (zkCallback-258-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (3) -> (4)
   [junit4]   2> 101418 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101463 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58989.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101463 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58990.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101485 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101485 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58992.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101489 INFO  (jetty-launcher-237-thread-1) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node1/.
   [junit4]   2> 101513 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58988.solr.node' (registry 
'solr.node') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101531 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58989.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101531 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58990.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101531 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58989.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101531 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58990.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101535 INFO  (jetty-launcher-237-thread-4) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node4/.
   [junit4]   2> 101535 INFO  (jetty-launcher-237-thread-2) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node2/.
   [junit4]   2> 101541 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58988.solr.jvm' (registry 
'solr.jvm') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101541 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 'solr_58988.solr.jetty' (registry 
'solr.jetty') enabled at server: com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 101542 INFO  (jetty-launcher-237-thread-3) [    ] 
o.a.s.c.CorePropertiesLocator Found 0 core definitions underneath 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node3/.
   [junit4]   2> 101659 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 101661 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58986/solr ready
   [junit4]   2> 101676 INFO  (qtp1501490789-1651) [    ] 
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> 101679 INFO  (OverseerThreadFactory-805-thread-1) [    ] 
o.a.s.c.CreateCollectionCmd Create collection collection1
   [junit4]   2> 101798 INFO  
(OverseerStateUpdate-98733888071204874-127.0.0.1:58989_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard1",
   [junit4]   2>   "core":"collection1_shard1_replica_n1",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:58988/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 101802 INFO  
(OverseerStateUpdate-98733888071204874-127.0.0.1:58989_solr-n_0000000000) [    
] o.a.s.c.o.SliceMutator createReplica() {
   [junit4]   2>   "operation":"ADDREPLICA",
   [junit4]   2>   "collection":"collection1",
   [junit4]   2>   "shard":"shard2",
   [junit4]   2>   "core":"collection1_shard2_replica_n2",
   [junit4]   2>   "state":"down",
   [junit4]   2>   "base_url":"http://127.0.0.1:58989/solr";,
   [junit4]   2>   "type":"NRT"} 
   [junit4]   2> 102008 INFO  (qtp358555498-1630) [    ] 
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> 102008 INFO  (qtp1541807688-1640) [    ] 
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> 102008 INFO  (qtp358555498-1630) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 102008 INFO  (qtp1541807688-1640) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 102122 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 102122 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 102122 INFO  (zkCallback-257-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 102122 INFO  (zkCallback-256-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103026 INFO  (qtp358555498-1630) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 103027 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SolrConfig 
Using Lucene MatchVersion: 8.0.0
   [junit4]   2> 103037 INFO  (qtp358555498-1630) [    ] o.a.s.s.IndexSchema 
[collection1_shard1_replica_n1] Schema name=test
   [junit4]   2> 103040 WARN  (qtp358555498-1630) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.TrieIntField]. Please consult documentation how to replace it accordingly.
   [junit4]   2> 103042 WARN  (qtp358555498-1630) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.TrieFloatField]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 103043 WARN  (qtp358555498-1630) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.TrieLongField]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 103045 WARN  (qtp358555498-1630) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.TrieDoubleField]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 103048 INFO  (qtp1541807688-1640) [    ] o.a.s.s.IndexSchema 
[collection1_shard2_replica_n2] Schema name=test
   [junit4]   2> 103049 WARN  (qtp358555498-1630) [    ] 
o.a.s.c.SolrResourceLoader Solr loaded a deprecated plugin/analysis class 
[solr.TrieDateField]. Please consult documentation how to replace it 
accordingly.
   [junit4]   2> 103108 WARN  (qtp358555498-1630) [    ] o.a.s.s.IndexSchema 
Field lowerfilt1and2 is not multivalued and destination for multiple copyFields 
(2)
   [junit4]   2> 103108 WARN  (qtp358555498-1630) [    ] o.a.s.s.IndexSchema 
Field text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 103108 INFO  (qtp358555498-1630) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 103108 INFO  (qtp358555498-1630) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard1_replica_n1' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 103108 INFO  (qtp358555498-1630) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_58988.solr.core.collection1.shard1.replica_n1' (registry 
'solr.core.collection1.shard1.replica_n1') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 103109 INFO  (qtp358555498-1630) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 103109 INFO  (qtp358555498-1630) [    ] o.a.s.c.SolrCore 
[[collection1_shard1_replica_n1] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node3/collection1_shard1_replica_n1],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node3/./collection1_shard1_replica_n1/data/]
   [junit4]   2> 103119 WARN  (qtp1541807688-1640) [    ] o.a.s.s.IndexSchema 
Field lowerfilt1and2 is not multivalued and destination for multiple copyFields 
(2)
   [junit4]   2> 103119 WARN  (qtp1541807688-1640) [    ] o.a.s.s.IndexSchema 
Field text is not multivalued and destination for multiple copyFields (3)
   [junit4]   2> 103119 INFO  (qtp1541807688-1640) [    ] o.a.s.s.IndexSchema 
Loaded schema test/1.6 with uniqueid field id
   [junit4]   2> 103119 INFO  (qtp1541807688-1640) [    ] o.a.s.c.CoreContainer 
Creating SolrCore 'collection1_shard2_replica_n2' using configuration from 
collection collection1, trusted=true
   [junit4]   2> 103119 INFO  (qtp1541807688-1640) [    ] 
o.a.s.m.r.SolrJmxReporter JMX monitoring for 
'solr_58989.solr.core.collection1.shard2.replica_n2' (registry 
'solr.core.collection1.shard2.replica_n2') enabled at server: 
com.sun.jmx.mbeanserver.JmxMBeanServer@64cf6218
   [junit4]   2> 103119 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SolrCore 
solr.RecoveryStrategy.Builder
   [junit4]   2> 103119 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SolrCore 
[[collection1_shard2_replica_n2] ] Opening new SolrCore at 
[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node2/collection1_shard2_replica_n2],
 
dataDir=[/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001/tempDir-001/node2/./collection1_shard2_replica_n2/data/]
   [junit4]   2> 103162 INFO  (qtp358555498-1630) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 103162 INFO  (qtp358555498-1630) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 103164 INFO  (qtp358555498-1630) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 103164 INFO  (qtp358555498-1630) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 103165 INFO  (qtp358555498-1630) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7cf72bbe[collection1_shard1_replica_n1] main]
   [junit4]   2> 103167 INFO  (qtp358555498-1630) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 103167 INFO  (qtp358555498-1630) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 103168 INFO  (qtp358555498-1630) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 103168 INFO  (qtp358555498-1630) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579742211280470016
   [junit4]   2> 103169 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@7cf72bbe[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103172 INFO  (qtp1541807688-1640) [    ] o.a.s.u.UpdateHandler 
Using UpdateLog implementation: org.apache.solr.update.UpdateLog
   [junit4]   2> 103172 INFO  (qtp1541807688-1640) [    ] o.a.s.u.UpdateLog 
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100 
maxNumLogsToKeep=10 numVersionBuckets=65536
   [junit4]   2> 103174 INFO  (qtp1541807688-1640) [    ] o.a.s.u.CommitTracker 
Hard AutoCommit: disabled
   [junit4]   2> 103174 INFO  (qtp1541807688-1640) [    ] o.a.s.u.CommitTracker 
Soft AutoCommit: disabled
   [junit4]   2> 103175 INFO  (qtp358555498-1630) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 103176 INFO  (qtp358555498-1630) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 103176 INFO  (qtp358555498-1630) [    ] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 103176 INFO  (qtp358555498-1630) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 103176 INFO  (qtp358555498-1630) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/ has no replicas
   [junit4]   2> 103176 INFO  (qtp358555498-1630) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 103176 INFO  (qtp1541807688-1640) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@5bfcf25[collection1_shard2_replica_n2] main]
   [junit4]   2> 103178 INFO  (qtp1541807688-1640) [    ] 
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase: 
/configs/conf
   [junit4]   2> 103179 INFO  (qtp1541807688-1640) [    ] 
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using 
ZooKeeperStorageIO:path=/configs/conf
   [junit4]   2> 103180 INFO  (qtp1541807688-1640) [    ] 
o.a.s.h.ReplicationHandler Commits will be reserved for 10000ms.
   [junit4]   2> 103180 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@5bfcf25[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 103180 INFO  (qtp1541807688-1640) [    ] o.a.s.u.UpdateLog 
Could not find max version in index or recent updates, using new clock 
1579742211293052928
   [junit4]   2> 103184 INFO  (qtp358555498-1630) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/ shard1
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] 
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] 
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SyncStrategy 
Sync replicas to http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SyncStrategy 
Sync Success - now sync replicas to me
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] o.a.s.c.SyncStrategy 
http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/ has no replicas
   [junit4]   2> 103191 INFO  (qtp1541807688-1640) [    ] 
o.a.s.c.ShardLeaderElectionContext Found all replicas participating in 
election, clear LIR
   [junit4]   2> 103209 INFO  (qtp1541807688-1640) [    ] 
o.a.s.c.ShardLeaderElectionContext I am the new leader: 
http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/ shard2
   [junit4]   2> 103324 INFO  (zkCallback-257-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103324 INFO  (zkCallback-256-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103324 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103324 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103359 INFO  (qtp358555498-1630) [    ] o.a.s.c.ZkController I 
am the leader, no recovery necessary
   [junit4]   2> 103361 INFO  (qtp358555498-1630) [    ] 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=1353
   [junit4]   2> 103384 INFO  (qtp1541807688-1640) [    ] o.a.s.c.ZkController 
I am the leader, no recovery necessary
   [junit4]   2> 103388 INFO  (qtp1541807688-1640) [    ] 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=1380
   [junit4]   2> 103392 INFO  (qtp1501490789-1651) [    ] 
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most 
30 seconds. Check all shard replicas
   [junit4]   2> 103498 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103498 INFO  (zkCallback-257-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103498 INFO  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103498 INFO  (zkCallback-256-thread-2) [    ] 
o.a.s.c.c.ZkStateReader A cluster state change: [WatchedEvent 
state:SyncConnected type:NodeDataChanged 
path:/collections/collection1/state.json] for collection [collection1] has 
occurred - updating... (live nodes size: [4])
   [junit4]   2> 103681 INFO  
(OverseerCollectionConfigSetProcessor-98733888071204874-127.0.0.1:58989_solr-n_0000000000)
 [    ] o.a.s.c.OverseerTaskQueue Response ZK path: 
/overseer/collection-queue-work/qnr-0000000000 doesn't exist.  Requestor may 
have disconnected from ZooKeeper
   [junit4]   2> 104402 INFO  (qtp1501490789-1651) [    ] 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=2726
   [junit4]   2> 104406 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection: 
collection1 failOnTimeout:true timeout (sec):90
   [junit4]   2> 104407 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: collection1
   [junit4]   2> 104439 INFO  
(TEST-StreamExpressionTest.testAscend-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testAscend
   [junit4]   2> 104447 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742212619501568)} 0 2
   [junit4]   2> 104449 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212623695872,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104449 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104449 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104450 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212624744448,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104450 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104450 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104450 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104450 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104450 INFO  (qtp1541807688-1642) [    ] 
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=*:*
 (-1579742212615307264),commit=} 0 9
   [junit4]   2> 104454 INFO  (qtp651175450-1659) [    ] 
o.a.s.c.TransientSolrCoreCacheDefault Allocating transient cache for 2147483647 
transient cores
   [junit4]   2> 104459 INFO  (qtp358555498-1635) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/stream 
params={indent=off&expr=asc(array(11.5,+12.3,+4,+3,+1,+0))&wt=json&version=2.2} 
status=0 QTime=2
   [junit4]   2> 104461 INFO  
(TEST-StreamExpressionTest.testAscend-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testAscend
   [junit4]   2> 104487 INFO  
(TEST-StreamExpressionTest.testRankTransform-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testRankTransform
   [junit4]   2> 104490 INFO  (qtp358555498-1628) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742212664590336)} 0 1
   [junit4]   2> 104491 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212667736064,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104491 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104491 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212667736064,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104491 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104491 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104491 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104492 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104492 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104492 INFO  (qtp1541807688-1644) [    ] 
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=*:*
 (-1579742212664590336),commit=} 0 4
   [junit4]   2> 104539 INFO  (qtp358555498-1632) [    ] 
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 
(1579742212670881792), id_10 (1579742212690804736), id_13 
(1579742212691853312), id_14 (1579742212691853313), id_16 
(1579742212691853314), id_17 (1579742212691853315), id_18 
(1579742212691853316), id_21 (1579742212692901888), id_22 
(1579742212692901889), id_23 (1579742212692901890), ... (125 adds)]} 0 45
   [junit4]   2> 104540 INFO  (qtp1541807688-1636) [    ] 
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 
(1579742212670881792), id_3 (1579742212690804736), id_4 (1579742212691853312), 
id_5 (1579742212691853313), id_6 (1579742212691853314), id_7 
(1579742212691853315), id_8 (1579742212692901888), id_9 (1579742212692901889), 
id_11 (1579742212692901890), id_12 (1579742212692901891), ... (125 adds)]} 0 47
   [junit4]   2> 104543 INFO  (qtp358555498-1635) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212722262016,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104543 INFO  (qtp358555498-1635) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742212722262016
   [junit4]   2> 104543 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212722262016,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104543 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742212722262016
   [junit4]   2> 104560 INFO  (qtp1541807688-1641) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@62efc43b[collection1_shard2_replica_n2] main]
   [junit4]   2> 104560 INFO  (qtp358555498-1635) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1771c02b[collection1_shard1_replica_n1] main]
   [junit4]   2> 104561 INFO  (qtp358555498-1635) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104561 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104561 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@62efc43b[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c125)))}
   [junit4]   2> 104561 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 18
   [junit4]   2> 104562 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@1771c02b[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(8.0.0):c125)))}
   [junit4]   2> 104562 INFO  (qtp358555498-1635) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 19
   [junit4]   2> 104562 INFO  (qtp358555498-1633) [    ] 
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 21
   [junit4]   2> 104568 INFO  (qtp358555498-1628) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/stream 
params={indent=off&expr=let(a%3Dtimeseries(collection1,+q%3D"*:*",+start%3D"2013-01-01T01:00:00.000Z",+end%3D"2016-12-01T01:00:00.000Z",+gap%3D"%2B1YEAR",+field%3D"test_dt",+count(*),+sum(price_f),+max(price_f),+min(price_f)),+c%3Dcol(a,+max(price_f)),+tuple(reverse%3Drev(c),+ranked%3Drank(c)))&wt=json&version=2.2}
 status=0 QTime=2
   [junit4]   2> 104573 INFO  (qtp358555498-1628) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 104574 INFO  (qtp358555498-1628) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58986/solr ready
   [junit4]   2> 104624 INFO  (qtp1541807688-1642) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={df=text&distrib=false&_stateVer_=collection1:4&_facet_={}&fl=id&fl=score&shards.purpose=1048580&start=0&fsv=true&shard.url=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&rows=0&version=2&q=*:*&json.facet={"timeseries":{"type":"range","field":"test_dt","start":"2013-01-01T01:00:00.000Z","end":"2016-12-01T01:00:00.000Z","gap":"%2B1YEAR","facet":{"facet_0":"sum(price_f)","facet_1":"max(price_f)","facet_2":"min(price_f)"}}}&field=test_dt&NOW=1506559574849&isShard=true&wt=javabin}
 hits=125 status=0 QTime=30
   [junit4]   2> 104624 INFO  (qtp358555498-1634) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={df=text&distrib=false&_stateVer_=collection1:4&_facet_={}&fl=id&fl=score&shards.purpose=1048580&start=0&fsv=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&rows=0&version=2&q=*:*&json.facet={"timeseries":{"type":"range","field":"test_dt","start":"2013-01-01T01:00:00.000Z","end":"2016-12-01T01:00:00.000Z","gap":"%2B1YEAR","facet":{"facet_0":"sum(price_f)","facet_1":"max(price_f)","facet_2":"min(price_f)"}}}&field=test_dt&NOW=1506559574849&isShard=true&wt=javabin}
 hits=125 status=0 QTime=30
   [junit4]   2> 104627 INFO  (qtp358555498-1631) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&json.facet={"timeseries":{"type":"range","field":"test_dt","start":"2013-01-01T01:00:00.000Z","end":"2016-12-01T01:00:00.000Z","gap":"%2B1YEAR","facet":{"facet_0":"sum(price_f)","facet_1":"max(price_f)","facet_2":"min(price_f)"}}}&_stateVer_=collection1:4&field=test_dt&rows=0&wt=javabin&version=2}
 hits=250 status=0 QTime=51
   [junit4]   2> 104635 INFO  
(TEST-StreamExpressionTest.testRankTransform-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testRankTransform
   [junit4]   2> 104667 INFO  
(TEST-StreamExpressionTest.testPriorityStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testPriorityStream
   [junit4]   2> 104671 INFO  (qtp358555498-1635) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7992a055[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 104671 INFO  (qtp1541807688-1645) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2c63424d[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 104672 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742212853334016)} 0 3
   [junit4]   2> 104673 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212858576896,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104673 INFO  (qtp1541807688-1644) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212858576896,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104673 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742212858576896
   [junit4]   2> 104673 INFO  (qtp1541807688-1644) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742212858576896
   [junit4]   2> 104675 INFO  (qtp1541807688-1644) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@7384b302[collection1_shard2_replica_n2] main]
   [junit4]   2> 104675 INFO  (qtp1541807688-1644) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104676 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@7384b302[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104676 INFO  (qtp358555498-1633) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1f91e5d0[collection1_shard1_replica_n1] main]
   [junit4]   2> 104676 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104677 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@1f91e5d0[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104677 INFO  (qtp1541807688-1644) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 4
   [junit4]   2> 104678 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 5
   [junit4]   2> 104678 INFO  (qtp358555498-1635) [    ] 
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=*:*
 (-1579742212853334016),commit=} 0 10
   [junit4]   2> 104682 INFO  (qtp1541807688-1636) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[2 
(1579742212865916928), 3 (1579742212868014080), 5 (1579742212868014081), 6 
(1579742212868014082), 7 (1579742212868014083), 9 (1579742212868014084)]} 0 2
   [junit4]   2> 104685 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[0 
(1579742212865916928), 4 (1579742212870111232), 1 (1579742212870111233), 8 
(1579742212871159808)]} 0 5
   [junit4]   2> 104686 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212872208384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104686 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742212872208384
   [junit4]   2> 104686 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742212872208384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104686 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742212872208384
   [junit4]   2> 104693 INFO  (qtp358555498-1632) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@286e11f0[collection1_shard1_replica_n1] main]
   [junit4]   2> 104693 INFO  (qtp1541807688-1641) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@445951c[collection1_shard2_replica_n2] main]
   [junit4]   2> 104693 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104693 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104694 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@445951c[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.0.0):c6)))}
   [junit4]   2> 104694 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@286e11f0[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(8.0.0):c4)))}
   [junit4]   2> 104694 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 8
   [junit4]   2> 104694 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 8
   [junit4]   2> 104694 INFO  (qtp1541807688-1640) [    ] 
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 9
   [junit4]   2> 104700 INFO  
(TEST-StreamExpressionTest.testPriorityStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 104702 INFO  
(TEST-StreamExpressionTest.testPriorityStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58986/solr ready
   [junit4]   2> 104705 INFO  (qtp1541807688-1642) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 104705 INFO  (qtp1541807688-1642) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 104705 INFO  (qtp358555498-1634) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506559574977&ids=1000000&isShard=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get}
 status=0 QTime=0
   [junit4]   2> 104706 INFO  (qtp1541807688-1642) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/get 
params={qt=/get&ids=1000000&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 104710 INFO  (qtp1541807688-1645) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&rows=500&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 104710 INFO  (qtp358555498-1628) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&rows=500&wt=json&version=2.2}
 hits=1 status=0 QTime=0
   [junit4]   2> 104713 INFO  (qtp358555498-1635) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&collection=collection1&wt=javabin&version=2}{add=[1000000
 (1579742212899471360)]} 0 0
   [junit4]   2> 104716 INFO  (qtp1541807688-1640) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 104716 INFO  (qtp1541807688-1640) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 104717 INFO  (qtp358555498-1632) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506559574989&ids=1000000&isShard=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get}
 status=0 QTime=0
   [junit4]   2> 104717 INFO  (qtp1541807688-1640) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/get 
params={qt=/get&ids=1000000&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 104720 INFO  (qtp358555498-1628) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212871159808}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 104720 INFO  (qtp1541807688-1643) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212868014083}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=1
   [junit4]   2> 104722 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&collection=collection1&wt=javabin&version=2}{add=[1000000
 (1579742212908908544)]} 0 0
   [junit4]   2> 104724 INFO  (qtp1541807688-1641) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 104724 INFO  (qtp1541807688-1641) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 104725 INFO  (qtp358555498-1635) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506559574997&ids=2000000&isShard=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get}
 status=0 QTime=0
   [junit4]   2> 104725 INFO  (qtp1541807688-1641) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/get 
params={qt=/get&ids=2000000&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 104726 INFO  (qtp1541807688-1636) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=a_s:hello1&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&rows=500&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 104726 INFO  (qtp358555498-1632) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=a_s:hello1&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&rows=500&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 104732 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&collection=collection1&wt=javabin&version=2}{add=[2000000
 (1579742212919394304)]} 0 0
   [junit4]   2> 104734 INFO  (qtp1541807688-1644) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 104734 INFO  (qtp1541807688-1644) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 104735 INFO  (qtp358555498-1628) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506559575007&ids=1000000&isShard=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get}
 status=0 QTime=0
   [junit4]   2> 104735 INFO  (qtp1541807688-1644) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/get 
params={qt=/get&ids=1000000&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 104737 INFO  (qtp1541807688-1645) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212868014083}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 104738 INFO  (qtp358555498-1635) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=a_s:hello&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212871159808}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 104739 INFO  (qtp358555498-1634) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&collection=collection1&wt=javabin&version=2}{add=[1000000
 (1579742212927782912)]} 0 0
   [junit4]   2> 104742 INFO  (qtp1541807688-1642) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard2=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/
   [junit4]   2> 104742 INFO  (qtp1541807688-1642) [    ] 
o.a.s.h.c.RealTimeGetComponent 
LOOKUP_SLICE:shard1=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/
   [junit4]   2> 104742 INFO  (qtp358555498-1631) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/get 
params={distrib=false&qt=/get&omitHeader=true&shards.purpose=1&NOW=1506559575015&ids=2000000&isShard=true&shard.url=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2&shards.qt=/get}
 status=0 QTime=0
   [junit4]   2> 104743 INFO  (qtp1541807688-1642) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/get 
params={qt=/get&ids=2000000&wt=javabin&version=2} status=0 QTime=1
   [junit4]   2> 104745 INFO  (qtp1541807688-1643) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=a_s:hello1&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212868014084}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 104745 INFO  (qtp358555498-1628) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=a_s:hello1&distrib=false&fl=id,a_i,_version_&initialCheckpoint=0&sort=_version_+asc&fq={!frange+cost%3D100+incl%3Dfalse+l%3D1579742212870111233}_version_&rows=500&wt=json&version=2.2}
 hits=0 status=0 QTime=0
   [junit4]   2> 104747 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&collection=collection1&wt=javabin&version=2}{add=[2000000
 (1579742212935122944)]} 0 0
   [junit4]   2> 104749 INFO  
(TEST-StreamExpressionTest.testPriorityStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testPriorityStream
   [junit4]   2> 104775 INFO  
(TEST-StreamExpressionTest.testTupleStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testTupleStream
   [junit4]   2> 104790 INFO  (qtp1541807688-1644) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@2ff31619[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 104808 INFO  (qtp358555498-1632) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@245305c2[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 104809 INFO  (qtp358555498-1632) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@9aba20a[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 104810 INFO  (qtp1541807688-1644) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742212966580224)} 0 33
   [junit4]   2> 104811 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213003280384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104811 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742213003280384
   [junit4]   2> 104811 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213003280384,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104811 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742213003280384
   [junit4]   2> 104811 INFO  (qtp358555498-1631) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@402b7a4c[collection1_shard1_replica_n1] main]
   [junit4]   2> 104811 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104812 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@402b7a4c[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104813 INFO  (qtp1541807688-1641) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@53024a4d[collection1_shard2_replica_n2] main]
   [junit4]   2> 104813 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104814 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@53024a4d[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104814 INFO  (qtp1541807688-1641) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 3
   [junit4]   2> 104814 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 3
   [junit4]   2> 104815 INFO  (qtp358555498-1632) [    ] 
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=*:*
 (-1579742212966580224),commit=} 0 39
   [junit4]   2> 104819 INFO  (qtp1541807688-1640) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[hello 
(1579742213008523264), hello1 (1579742213010620416)]} 0 3
   [junit4]   2> 104820 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213012717568,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104820 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104820 INFO  (qtp1541807688-1642) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213012717568,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104820 INFO  (qtp1541807688-1642) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742213012717568
   [junit4]   2> 104820 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104820 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104825 INFO  (qtp1541807688-1642) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@67f8a433[collection1_shard2_replica_n2] main]
   [junit4]   2> 104825 INFO  (qtp1541807688-1642) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104826 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@67f8a433[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(8.0.0):c2)))}
   [junit4]   2> 104826 INFO  (qtp1541807688-1642) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 6
   [junit4]   2> 104826 INFO  (qtp1541807688-1636) [    ] 
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 7
   [junit4]   2> 104830 INFO  (qtp1541807688-1645) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={indent=off&expr=tuple(results%3Dsearch(collection1,+q%3D"*:*",+fl%3D"id,test_t",+sort%3D"id+desc"),+sum%3Dadd(1,1))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 104833 INFO  (qtp1541807688-1641) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,test_t&sort=id+desc&wt=json&version=2.2} 
hits=2 status=0 QTime=0
   [junit4]   2> 104833 INFO  (qtp358555498-1630) [    ] o.a.s.c.S.Request 
[collection1_shard1_replica_n1]  webapp=/solr path=/select 
params={q=*:*&distrib=false&fl=id,test_t&sort=id+desc&wt=json&version=2.2} 
hits=0 status=0 QTime=0
   [junit4]   2> 104836 INFO  
(TEST-StreamExpressionTest.testTupleStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testTupleStream
   [junit4]   2> 104873 INFO  
(TEST-StreamExpressionTest.testFreqTable-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testFreqTable
   [junit4]   2> 104875 INFO  (qtp1541807688-1642) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@647b1182[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 104875 INFO  (qtp1541807688-1642) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742213069340672)} 0 1
   [junit4]   2> 104876 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213071437824,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104876 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 104876 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213071437824,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 104876 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742213071437824
   [junit4]   2> 104876 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104876 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 0
   [junit4]   2> 104891 INFO  (qtp1541807688-1643) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@22c66ccc[collection1_shard2_replica_n2] main]
   [junit4]   2> 104892 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 104893 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@22c66ccc[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
   [junit4]   2> 104893 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 17
   [junit4]   2> 104893 INFO  (qtp358555498-1635) [    ] 
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=*:*
 (-1579742213069340672),commit=} 0 19
   [junit4]   2> 104897 INFO  (qtp1541807688-1644) [    ] o.a.s.c.S.Request 
[collection1_shard2_replica_n2]  webapp=/solr path=/stream 
params={indent=off&expr=freqTable(array(2,4,6,8,10,12,12,4,8,8,8,2))&wt=json&version=2.2}
 status=0 QTime=0
   [junit4]   2> 104901 INFO  
(TEST-StreamExpressionTest.testFreqTable-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testFreqTable
   [junit4]   2> 104935 INFO  
(TEST-StreamExpressionTest.testUniqueStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Starting testUniqueStream
   [junit4]   2> 105222 INFO  (qtp358555498-1633) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742213155323904)} 0 266
   [junit4]   2> 105224 INFO  (qtp358555498-1628) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213436342272,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105224 INFO  (qtp358555498-1628) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 105224 INFO  (qtp1541807688-1640) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213436342272,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105224 INFO  (qtp1541807688-1640) [    ] 
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
   [junit4]   2> 105225 INFO  (qtp358555498-1628) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 105225 INFO  (qtp358555498-1628) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 105225 INFO  (qtp1541807688-1640) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 105225 INFO  (qtp1541807688-1640) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 1
   [junit4]   2> 105226 INFO  (qtp1541807688-1641) [    ] 
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=*:*
 (-1579742213154275328),commit=} 0 271
   [junit4]   2> 105231 INFO  (qtp358555498-1630) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[0 
(1579742213439488000), 4 (1579742213442633728), 1 (1579742213443682304)]} 0 3
   [junit4]   2> 105232 INFO  (qtp1541807688-1636) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={_stateVer_=collection1:4&wt=javabin&version=2}{add=[2 
(1579742213440536576), 3 (1579742213444730880)]} 0 4
   [junit4]   2> 105234 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213446828032,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105234 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213446828032,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105234 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423 
commitCommandVersion:1579742213446828032
   [junit4]   2> 105234 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742213446828032
   [junit4]   2> 105242 INFO  (qtp358555498-1631) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@1273ea1[collection1_shard1_replica_n1] main]
   [junit4]   2> 105243 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 105244 INFO  (searcherExecutor-814-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard1_replica_n1] Registered new searcher 
Searcher@1273ea1[collection1_shard1_replica_n1] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):c3)))}
   [junit4]   2> 105244 INFO  (qtp358555498-1631) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 10
   [junit4]   2> 105250 INFO  (qtp1541807688-1645) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@4864aea7[collection1_shard2_replica_n2] main]
   [junit4]   2> 105250 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.DirectUpdateHandler2 end_commit_flush
   [junit4]   2> 105251 INFO  (searcherExecutor-815-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2] Registered new searcher 
Searcher@4864aea7[collection1_shard2_replica_n2] 
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(8.0.0):c2)))}
   [junit4]   2> 105251 INFO  (qtp1541807688-1645) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard2_replica_n2]  
webapp=/solr path=/update 
params={update.distrib=FROMLEADER&waitSearcher=true&openSearcher=true&commit=true&softCommit=false&distrib.from=http://127.0.0.1:58988/solr/collection1_shard1_replica_n1/&commit_end_point=true&wt=javabin&version=2&expungeDeletes=false}{commit=}
 0 17
   [junit4]   2> 105252 INFO  (qtp358555498-1634) [    ] 
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 18
   [junit4]   2> 105257 INFO  
(TEST-StreamExpressionTest.testUniqueStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (4)
   [junit4]   2> 105259 INFO  
(TEST-StreamExpressionTest.testUniqueStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.c.s.i.ZkClientClusterStateProvider Cluster at 127.0.0.1:58986/solr ready
   [junit4]   2> 105263 INFO  (qtp1541807688-1643) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=2 status=0 QTime=1
   [junit4]   2> 105263 INFO  (qtp358555498-1635) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=3 status=0 QTime=1
   [junit4]   2> 105268 INFO  (qtp358555498-1630) [    ] 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+desc,+a_i+desc&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 105268 INFO  (qtp1541807688-1641) [    ] 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+desc,+a_i+desc&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 105271 INFO  (qtp1541807688-1643) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 105271 INFO  (qtp358555498-1632) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 105274 INFO  (qtp358555498-1630) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=3 status=0 QTime=0
   [junit4]   2> 105274 INFO  (qtp1541807688-1644) [    ] 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,+a_i+asc&wt=json&version=2.2}
 hits=2 status=0 QTime=0
   [junit4]   2> 105279 INFO  
(TEST-StreamExpressionTest.testUniqueStream-seed#[EBF4AA0B094B04EA]) [    ] 
o.a.s.SolrTestCaseJ4 ###Ending testUniqueStream
   [junit4]   2> 105305 INFO  
(TEST-StreamExpressionTest.testParameterSubstitution-seed#[EBF4AA0B094B04EA]) [ 
   ] o.a.s.SolrTestCaseJ4 ###Starting testParameterSubstitution
   [junit4]   2> 105307 INFO  (qtp1541807688-1642) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@357882b6[collection1_shard2_replica_n2] realtime]
   [junit4]   2> 105307 INFO  (qtp358555498-1634) [    ] 
o.a.s.s.SolrIndexSearcher Opening 
[Searcher@48ed7783[collection1_shard1_replica_n1] realtime]
   [junit4]   2> 105308 INFO  (qtp358555498-1634) [    ] 
o.a.s.u.p.LogUpdateProcessorFactory [collection1_shard1_replica_n1]  
webapp=/solr path=/update 
params={update.distrib=TOLEADER&distrib.from=http://127.0.0.1:58989/solr/collection1_shard2_replica_n2/&wt=javabin&version=2}{deleteByQuery=*:*
 (-1579742213522325504)} 0 1
   [junit4]   2> 105308 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213524422656,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105308 INFO  (qtp358555498-1632) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@72fc8f28 
commitCommandVersion:1579742213524422656
   [junit4]   2> 105308 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.DirectUpdateHandler2 start 
commit{_version_=1579742213524422656,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
   [junit4]   2> 105309 INFO  (qtp1541807688-1643) [    ] 
o.a.s.u.SolrIndexWriter Calling setCommitData with 
IW:org.apache.solr.update.SolrIndexWriter@4e9f6423

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

back-1884-thread-1) [    ] o.a.s.c.c.ZkStateReader Updated live nodes from 
ZooKeeper... (3) -> (2)
   [junit4]   2> 217662 INFO  (coreCloseExecutor-1007-thread-1) [    ] 
o.a.s.c.SolrCore [collection1_shard2_replica_n2]  CLOSING SolrCore 
org.apache.solr.core.SolrCore@a92198f
   [junit4]   2> 217662 INFO  (coreCloseExecutor-1007-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.core.collection1.shard2.replica_n2, tag=177346959
   [junit4]   2> 217662 INFO  (coreCloseExecutor-1007-thread-1) [    ] 
o.a.s.m.r.SolrJmxReporter Closing reporter 
[org.apache.solr.metrics.reporters.SolrJmxReporter@65d2a516: rootName = 
solr_58989, domain = solr.core.collection1.shard2.replica_n2, service url = 
null, agent id = null] for registry solr.core.collection1.shard2.replica_n2 / 
com.codahale.metrics.MetricRegistry@225e7be0
   [junit4]   2> 217668 INFO  (coreCloseExecutor-1006-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.collection1.shard1.leader, tag=1349278742
   [junit4]   2> 217671 INFO  (coreCloseExecutor-1007-thread-1) [    ] 
o.a.s.m.SolrMetricManager Closing metric reporters for 
registry=solr.collection.collection1.shard2.leader, tag=177346959
   [junit4]   2> 217675 WARN  (zkCallback-256-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 217675 INFO  (jetty-closer-238-thread-3) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@7a4e18b2{/solr,null,UNAVAILABLE}
   [junit4]   2> 217676 INFO  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (2) -> (1)
   [junit4]   2> 217677 INFO  (jetty-closer-238-thread-2) [    ] 
o.a.s.c.Overseer Overseer 
(id=98733888071204874-127.0.0.1:58989_solr-n_0000000000) closing
   [junit4]   2> 217677 INFO  
(OverseerStateUpdate-98733888071204874-127.0.0.1:58989_solr-n_0000000000) [    
] o.a.s.c.Overseer Overseer Loop exiting : 127.0.0.1:58989_solr
   [junit4]   2> 217679 WARN  (zkCallback-257-thread-1) [    ] 
o.a.s.c.c.ZkStateReader ZooKeeper watch triggered, but Solr cannot talk to ZK: 
[KeeperErrorCode = Session expired for /live_nodes]
   [junit4]   2> 217680 INFO  (jetty-closer-238-thread-2) [    ] 
o.e.j.s.h.ContextHandler Stopped 
o.e.j.s.ServletContextHandler@28ff8783{/solr,null,UNAVAILABLE}
   [junit4]   2> 217681 ERROR 
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-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> 217682 INFO  
(SUITE-StreamExpressionTest-seed#[EBF4AA0B094B04EA]-worker) [    ] 
o.a.s.c.ZkTestServer connecting to 127.0.0.1:58986 58986
   [junit4]   2> 217711 INFO  (Thread-312) [    ] o.a.s.c.ZkTestServer 
connecting to 127.0.0.1:58986 58986
   [junit4]   2> 217815 WARN  (Thread-312) [    ] o.a.s.c.ZkTestServer Watch 
limit violations: 
   [junit4]   2> Maximum concurrent create/delete watches above limit:
   [junit4]   2> 
   [junit4]   2>        96      /solr/aliases.json
   [junit4]   2>        96      /solr/clusterprops.json
   [junit4]   2>        12      /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>        96      /solr/clusterstate.json
   [junit4]   2>        40      
/solr/collections/destinationCollection/state.json
   [junit4]   2>        30      
/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>        3       
/solr/overseer_elect/election/98733888071204874-127.0.0.1:58989_solr-n_0000000000
   [junit4]   2> 
   [junit4]   2> Maximum concurrent children watches above limit:
   [junit4]   2> 
   [junit4]   2>        96      /solr/live_nodes
   [junit4]   2>        96      /solr/collections
   [junit4]   2> 
   [junit4]   2> NOTE: leaving temporary files on disk at: 
/Users/jenkins/workspace/Lucene-Solr-master-MacOSX/solr/build/solr-solrj/test/J1/temp/solr.client.solrj.io.stream.StreamExpressionTest_EBF4AA0B094B04EA-001
   [junit4]   2> NOTE: test params are: codec=Asserting(Lucene70): 
{expr_s=PostingsFormat(name=Asserting), name_s=Lucene50(blocksize=128), 
iteration_i=Lucene50(blocksize=128), terms_ss=PostingsFormat(name=Memory), 
join2_s=PostingsFormat(name=Memory), multiDefault=PostingsFormat(name=Memory), 
subject=PostingsFormat(name=Memory), intDefault=BlockTreeOrds(blocksize=128), 
a_f=BlockTreeOrds(blocksize=128), a2_s=PostingsFormat(name=Asserting), 
falseNegative_i=BlockTreeOrds(blocksize=128), a_i=Lucene50(blocksize=128), 
level1_s=PostingsFormat(name=Asserting), body_t=Lucene50(blocksize=128), 
a_s=PostingsFormat(name=Asserting), a_t=PostingsFormat(name=Memory), 
id=Lucene50(blocksize=128), text=PostingsFormat(name=Asserting), 
alpha_d=Lucene50(blocksize=128), i_multi=Lucene50(blocksize=128), 
idf_d=BlockTreeOrds(blocksize=128), b_ls=BlockTreeOrds(blocksize=128), 
checkpoint_ss=Lucene50(blocksize=128), test_t=Lucene50(blocksize=128), 
ident_s=BlockTreeOrds(blocksize=128), order_i=PostingsFormat(name=Memory), 
error_d=PostingsFormat(name=Asserting), side_s=Lucene50(blocksize=128), 
truePositive_i=PostingsFormat(name=Asserting), 
miles_i=BlockTreeOrds(blocksize=128), field_s=BlockTreeOrds(blocksize=128), 
price_f=PostingsFormat(name=Memory), a1_s=BlockTreeOrds(blocksize=128), 
join1_i=PostingsFormat(name=Asserting), join3_i=Lucene50(blocksize=128), 
test_i=PostingsFormat(name=Memory), 
falsePositive_i=BlockTreeOrds(blocksize=128), 
field_i=PostingsFormat(name=Memory), s_multi=PostingsFormat(name=Asserting), 
col_s=BlockTreeOrds(blocksize=128), a_ss=PostingsFormat(name=Memory), 
level2_s=BlockTreeOrds(blocksize=128), score_f=PostingsFormat(name=Asserting), 
tv_text=BlockTreeOrds(blocksize=128), term_s=PostingsFormat(name=Memory), 
text_s=PostingsFormat(name=Asserting), timestamp=PostingsFormat(name=Memory), 
idfs_ds=PostingsFormat(name=Memory), featureSet_s=BlockTreeOrds(blocksize=128), 
weights_ds=Lucene50(blocksize=128), 
trueNegative_i=PostingsFormat(name=Asserting), 
index_i=BlockTreeOrds(blocksize=128), test_dt=PostingsFormat(name=Asserting), 
out_i=BlockTreeOrds(blocksize=128), whitetok=Lucene50(blocksize=128), 
_version_=BlockTreeOrds(blocksize=128)}, 
docValues:{expr_s=DocValuesFormat(name=Lucene70), 
name_s=DocValuesFormat(name=Lucene70), 
iteration_i=DocValuesFormat(name=Lucene70), 
terms_ss=DocValuesFormat(name=Asserting), 
join2_s=DocValuesFormat(name=Asserting), field_s=DocValuesFormat(name=Direct), 
multiDefault=DocValuesFormat(name=Asserting), 
price_f=DocValuesFormat(name=Asserting), a1_s=DocValuesFormat(name=Direct), 
intDefault=DocValuesFormat(name=Direct), a_f=DocValuesFormat(name=Direct), 
join1_i=DocValuesFormat(name=Lucene70), a2_s=DocValuesFormat(name=Lucene70), 
falseNegative_i=DocValuesFormat(name=Direct), 
a_i=DocValuesFormat(name=Lucene70), join3_i=DocValuesFormat(name=Lucene70), 
test_i=DocValuesFormat(name=Asserting), 
falsePositive_i=DocValuesFormat(name=Direct), 
field_i=DocValuesFormat(name=Asserting), 
level1_s=DocValuesFormat(name=Lucene70), 
s_multi=DocValuesFormat(name=Lucene70), col_s=DocValuesFormat(name=Direct), 
a_ss=DocValuesFormat(name=Asserting), level2_s=DocValuesFormat(name=Direct), 
a_s=DocValuesFormat(name=Lucene70), score_f=DocValuesFormat(name=Lucene70), 
term_s=DocValuesFormat(name=Asserting), text_s=DocValuesFormat(name=Lucene70), 
id=DocValuesFormat(name=Lucene70), timestamp=DocValuesFormat(name=Asserting), 
i_multi=DocValuesFormat(name=Lucene70), 
featureSet_s=DocValuesFormat(name=Direct), 
trueNegative_i=DocValuesFormat(name=Lucene70), 
index_i=DocValuesFormat(name=Direct), b_ls=DocValuesFormat(name=Direct), 
test_dt=DocValuesFormat(name=Lucene70), out_i=DocValuesFormat(name=Direct), 
checkpoint_ss=DocValuesFormat(name=Lucene70), 
ident_s=DocValuesFormat(name=Direct), order_i=DocValuesFormat(name=Asserting), 
_version_=DocValuesFormat(name=Direct), side_s=DocValuesFormat(name=Lucene70), 
truePositive_i=DocValuesFormat(name=Lucene70), 
miles_i=DocValuesFormat(name=Direct)}, maxPointsInLeafNode=1092, 
maxMBSortInHeap=6.284753517377091, sim=RandomSimilarity(queryNorm=true): {}, 
locale=ar-YE, timezone=America/Antigua
   [junit4]   2> NOTE: Mac OS X 10.11.6 x86_64/Oracle Corporation 9 
(64-bit)/cpus=3,threads=1,free=268597248,total=463470592
   [junit4]   2> NOTE: All tests run in this JVM: [TestV1toV2ApiMapper, 
CeilingEvaluatorTest, TestLBHttpSolrClient, MergeIndexesEmbeddedTest, 
ClientUtilsTest, CloudSolrClientMultiConstructorTest, 
SolrExampleStreamingBinaryTest, AnlysisResponseBaseTest, 
StreamExpressionToExpessionTest, GraphTest, ArcSineEvaluatorTest, 
QueryResponseTest, AddEvaluatorTest, SolrQueryTest, SolrParamTest, 
DocumentAnalysisResponseTest, LengthEvaluatorTest, ReverseEvaluatorTest, 
SineEvaluatorTest, CommonAdminParamsTest, RecursiveEvaluatorTest, 
TestDelegationTokenResponse, CosineEvaluatorTest, CloudSolrClientBuilderTest, 
GreaterThanEvaluatorTest, ArrayEvaluatorTest, TestRetryUtil, 
SelectWithEvaluatorsTest, TestJsonRecordReader, TestFastInputStream, 
HttpSolrClientBuilderTest, TestPolicy, SubtractEvaluatorTest, 
LessThanEvaluatorTest, SolrExampleBinaryTest, SolrExampleXMLTest, 
SolrExampleJettyTest, LargeVolumeBinaryJettyTest, LargeVolumeEmbeddedTest, 
LargeVolumeJettyTest, TestCoreAdmin, SolrSchemalessExampleTest, 
CloudSolrClientTest, StreamExpressionTest]
   [junit4] Completed [145/145 (1!)] on J1 in 116.71s, 114 tests, 1 failure <<< 
FAILURES!

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

Reply via email to