Build: https://jenkins.thetaphi.de/job/Lucene-Solr-master-Windows/6156/
Java: 32bit/jdk1.8.0_102 -server -XX:+UseParallelGC
2 tests failed.
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest
Error Message:
1 thread leaked from SUITE scope at
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest: 1)
Thread[id=2287, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-CloudSolrClientBuilderTest] at java.lang.Thread.sleep(Native
Method) at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest:
1) Thread[id=2287, name=Connection evictor, state=TIMED_WAITING,
group=TGRP-CloudSolrClientBuilderTest]
at java.lang.Thread.sleep(Native Method)
at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([6833755DB9F64C78]:0)
FAILED:
junit.framework.TestSuite.org.apache.solr.client.solrj.io.stream.StreamingTest
Error Message:
ObjectTracker found 1 object(s) that were not released!!! [InternalHttpClient]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
at
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498) at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$11.evaluate(RandomizedRunner.java:968)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Stack Trace:
java.lang.AssertionError: ObjectTracker found 1 object(s) that were not
released!!! [InternalHttpClient]
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
at
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
at
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at
sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:871)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$11.evaluate(RandomizedRunner.java:968)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$9.evaluate(RandomizedRunner.java:907)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$10.evaluate(RandomizedRunner.java:921)
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:367)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:809)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:460)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:880)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:781)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:816)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:827)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
at __randomizedtesting.SeedInfo.seed([6833755DB9F64C78]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.assertTrue(Assert.java:43)
at org.junit.Assert.assertNull(Assert.java:551)
at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:261)
at sun.reflect.GeneratedMethodAccessor24.invoke(Unknown Source)
at
sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:498)
at
com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1764)
at
com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:834)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:57)
at
org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:41)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:40)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:53)
at
org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:47)
at
org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:64)
at
org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:54)
at
com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at
com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:367)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 13221 lines...]
[junit4] Suite: org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest
[junit4] 2> Oct 04, 2016 1:14:37 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> WARNING: Will linger awaiting termination of 1 leaked
thread(s).
[junit4] 2> Oct 04, 2016 1:14:57 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl checkThreadLeaks
[junit4] 2> SEVERE: 1 thread leaked from SUITE scope at
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest:
[junit4] 2> 1) Thread[id=2287, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
[junit4] 2> at java.lang.Thread.sleep(Native Method)
[junit4] 2> at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> Oct 04, 2016 1:14:57 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: Starting to interrupt leaked threads:
[junit4] 2> 1) Thread[id=2287, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
[junit4] 2> Oct 04, 2016 1:14:57 AM
com.carrotsearch.randomizedtesting.ThreadLeakControl tryToInterruptAll
[junit4] 2> INFO: All leaked threads terminated.
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62),
sim=RandomSimilarity(queryNorm=true): {}, locale=es-CL, timezone=Pacific/Noumea
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102
(32-bit)/cpus=3,threads=1,free=111313296,total=245104640
[junit4] 2> NOTE: All tests run in this JVM: [SolrPingTest,
TestZkConfigManager, ConcurrentUpdateSolrClientBuilderTest,
BasicHttpSolrClientTest, GetByIdTest, SolrExceptionTest,
DocumentAnalysisResponseTest, SolrZkClientTest, StreamExpressionTest,
SolrQueryTest, TestConfigSetAdminRequest, SolrParamTest,
StreamExpressionParserTest, TestLBHttpSolrClient, MergeIndexesEmbeddedTest,
SolrExampleJettyTest, ContentStreamTest, ClientUtilsTest,
TestSuggesterResponse, TestClusteringResponse, SolrExampleBinaryTest,
LargeVolumeBinaryJettyTest, TestBatchUpdate, JettyWebappTest,
TestSpellCheckResponse, QueryResponseTest, TestNamedListCodec,
TestJavaBinCodec, TestDocumentObjectBinder, ModifiableSolrParamsTest,
SolrDocumentTest, FacetFieldTest, SolrSchemalessExampleTest,
CloudSolrClientBuilderTest]
[junit4] 2> NOTE: reproduce with: ant test
-Dtestcase=CloudSolrClientBuilderTest -Dtests.seed=6833755DB9F64C78
-Dtests.slow=true -Dtests.locale=es-CL -Dtests.timezone=Pacific/Noumea
-Dtests.asserts=true -Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J1 | CloudSolrClientBuilderTest (suite) <<<
[junit4] > Throwable #1:
com.carrotsearch.randomizedtesting.ThreadLeakError: 1 thread leaked from SUITE
scope at org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest:
[junit4] > 1) Thread[id=2287, name=Connection evictor,
state=TIMED_WAITING, group=TGRP-CloudSolrClientBuilderTest]
[junit4] > at java.lang.Thread.sleep(Native Method)
[junit4] > at
org.apache.http.impl.client.IdleConnectionEvictor$1.run(IdleConnectionEvictor.java:66)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([6833755DB9F64C78]:0)
[junit4] Completed [72/85 (1!)] on J1 in 21.52s, 6 tests, 1 error <<<
FAILURES!
[...truncated 37 lines...]
[junit4] Suite: org.apache.solr.client.solrj.io.stream.StreamingTest
[junit4] 2> Creating dataDir:
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.io.stream.StreamingTest_6833755DB9F64C78-001\init-core-data-001
[junit4] 2> 212749 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.SolrTestCaseJ4 Randomized ssl (false) and clientAuth (true) via:
@org.apache.solr.util.RandomizeSSL(reason=, value=NaN, ssl=NaN, clientAuth=NaN)
[junit4] 2> 212751 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.ZkTestServer STARTING ZK TEST SERVER
[junit4] 2> 212753 INFO (Thread-278) [ ] o.a.s.c.ZkTestServer client
port:0.0.0.0/0.0.0.0:0
[junit4] 2> 212753 INFO (Thread-278) [ ] o.a.s.c.ZkTestServer Starting
server
[junit4] 2> 212852 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.ZkTestServer start zk server on port:63225
[junit4] 2> 212866 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.Server jetty-9.3.8.v20160314
[junit4] 2> 212867 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.h.ContextHandler Started
o.e.j.s.ServletContextHandler@17cbfb0{/solr,null,AVAILABLE}
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.ServerConnector Started
ServerConnector@9c8a06{HTTP/1.1,[http/1.1]}{127.0.0.1:63229}
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.Server Started @217310ms
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.c.s.e.JettySolrRunner Jetty properties: {hostContext=/solr,
hostPort=63229}
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.s.SolrDispatchFilter ___ _ Welcome to Apache Solr™ version
7.0.0
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.s.SolrDispatchFilter / __| ___| |_ _ Starting in cloud mode on port null
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.s.SolrDispatchFilter \__ \/ _ \ | '_| Install dir: null
[junit4] 2> 212868 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.s.SolrDispatchFilter |___/\___/_|_| Start time:
2016-10-04T01:14:58.677Z
[junit4] 2> 212873 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.s.SolrDispatchFilter solr.xml found in ZooKeeper. Loading...
[junit4] 2> 212885 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860001, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 212890 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.c.ZkContainer Zookeeper client=127.0.0.1:63225/solr
[junit4] 2> 212940 INFO (jetty-launcher-761-thread-1)
[n:127.0.0.1:63229_solr ] o.a.s.c.OverseerElectionContext I am going to be
the leader 127.0.0.1:63229_solr
[junit4] 2> 212942 INFO (jetty-launcher-761-thread-1)
[n:127.0.0.1:63229_solr ] o.a.s.c.Overseer Overseer
(id=96701231829221379-127.0.0.1:63229_solr-n_0000000000) starting
[junit4] 2> 212953 INFO (jetty-launcher-761-thread-1)
[n:127.0.0.1:63229_solr ] o.a.s.c.ZkController Register node as live in
ZooKeeper:/live_nodes/127.0.0.1:63229_solr
[junit4] 2> 212957 INFO
(zkCallback-767-thread-1-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader Updated live nodes from
ZooKeeper... (0) -> (1)
[junit4] 2> 212994 INFO (jetty-launcher-761-thread-1)
[n:127.0.0.1:63229_solr ] o.a.s.c.CorePropertiesLocator Found 0 core
definitions underneath
C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.io.stream.StreamingTest_6833755DB9F64C78-001\tempDir-001\node1\.
[junit4] 2> 213000 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860004, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 213007 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 213020 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr ]
o.a.s.h.a.CollectionsHandler Invoked Collection Action :create with params
replicationFactor=1&collection.configName=conf&name=streams&action=CREATE&numShards=1&wt=javabin&version=2
and sendToOCPQueue=true
[junit4] 2> 213024 INFO
(OverseerThreadFactory-499-thread-1-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.CreateCollectionCmd Create collection
streams
[junit4] 2> 213134 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr ]
o.a.s.h.a.CoreAdminOperation core create command
qt=/admin/cores&collection.configName=conf&name=streams_shard1_replica1&action=CREATE&numShards=1&collection=streams&shard=shard1&wt=javabin&version=2
[junit4] 2> 213245 INFO
(zkCallback-767-thread-2-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/streams/state.json] for collection [streams] has occurred -
updating... (live nodes size: [1])
[junit4] 2> 214160 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.c.SolrConfig Using Lucene
MatchVersion: 7.0.0
[junit4] 2> 214169 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.s.IndexSchema
[streams_shard1_replica1] Schema name=test
[junit4] 2> 214212 WARN (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.s.IndexSchema
[streams_shard1_replica1] default search field in schema is text. WARNING:
Deprecated, please use 'df' on request instead.
[junit4] 2> 214213 WARN (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.s.IndexSchema Field
lowerfilt1and2 is not multivalued and destination for multiple copyFields (2)
[junit4] 2> 214213 WARN (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.s.IndexSchema Field text
is not multivalued and destination for multiple copyFields (3)
[junit4] 2> 214213 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.s.IndexSchema Loaded
schema test/1.6 with uniqueid field id
[junit4] 2> 214218 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 x:streams_shard1_replica1] o.a.s.c.CoreContainer Creating
SolrCore 'streams_shard1_replica1' using configuration from collection streams
[junit4] 2> 214218 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.SolrCore
[[streams_shard1_replica1] ] Opening new SolrCore at
[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.io.stream.StreamingTest_6833755DB9F64C78-001\tempDir-001\node1\streams_shard1_replica1],
dataDir=[C:\Users\jenkins\workspace\Lucene-Solr-master-Windows\solr\build\solr-solrj\test\J1\temp\solr.client.solrj.io.stream.StreamingTest_6833755DB9F64C78-001\tempDir-001\node1\.\streams_shard1_replica1\data\]
[junit4] 2> 214232 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.UpdateHandler Using UpdateLog implementation:
org.apache.solr.update.UpdateLog
[junit4] 2> 214232 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.u.UpdateLog
Initializing UpdateLog: dataDir= defaultSyncLevel=FLUSH numRecordsToKeep=100
maxNumLogsToKeep=10 numVersionBuckets=65536
[junit4] 2> 214234 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.CommitTracker Hard AutoCommit: disabled
[junit4] 2> 214234 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.CommitTracker Soft AutoCommit: disabled
[junit4] 2> 214235 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@46a0e2[streams_shard1_replica1]
main]
[junit4] 2> 214236 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.r.ManagedResourceStorage Configured ZooKeeperStorageIO with znodeBase:
/configs/conf
[junit4] 2> 214237 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.r.ManagedResourceStorage Loaded null at path _rest_managed.json using
ZooKeeperStorageIO:path=/configs/conf
[junit4] 2> 214237 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.h.ReplicationHandler Commits will be reserved for 10000
[junit4] 2> 214238 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@46a0e2[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 214238 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.u.UpdateLog
Could not find max version in index or recent updates, using new clock
1547219710820483072
[junit4] 2> 214247 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext Enough replicas found to continue.
[junit4] 2> 214247 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I may be the new leader - try and sync
[junit4] 2> 214247 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.SyncStrategy
Sync replicas to http://127.0.0.1:63229/solr/streams_shard1_replica1/
[junit4] 2> 214247 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.SyncStrategy
Sync Success - now sync replicas to me
[junit4] 2> 214247 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.SyncStrategy
http://127.0.0.1:63229/solr/streams_shard1_replica1/ has no replicas
[junit4] 2> 214254 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.c.ShardLeaderElectionContext I am the new leader:
http://127.0.0.1:63229/solr/streams_shard1_replica1/ shard1
[junit4] 2> 214358 INFO
(zkCallback-767-thread-3-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/streams/state.json] for collection [streams] has occurred -
updating... (live nodes size: [1])
[junit4] 2> 214406 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.ZkController
I am the leader, no recovery necessary
[junit4] 2> 214411 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.s.HttpSolrCall
[admin] webapp=null path=/admin/cores
params={qt=/admin/cores&collection.configName=conf&name=streams_shard1_replica1&action=CREATE&numShards=1&collection=streams&shard=shard1&wt=javabin&version=2}
status=0 QTime=1277
[junit4] 2> 214415 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr ]
o.a.s.h.a.CollectionsHandler Wait for new collection to be active for at most
30 seconds. Check all shard replicas
[junit4] 2> 214514 INFO
(zkCallback-767-thread-3-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/streams/state.json] for collection [streams] has occurred -
updating... (live nodes size: [1])
[junit4] 2> 215028 INFO
(OverseerCollectionConfigSetProcessor-96701231829221379-127.0.0.1:63229_solr-n_0000000000)
[n:127.0.0.1:63229_solr ] o.a.s.c.OverseerTaskQueue Response ZK path:
/overseer/collection-queue-work/qnr-0000000000 doesn't exist. Requestor may
have disconnected from ZooKeeper
[junit4] 2> 215416 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr ]
o.a.s.s.HttpSolrCall [admin] webapp=null path=/admin/collections
params={replicationFactor=1&collection.configName=conf&name=streams&action=CREATE&numShards=1&wt=javabin&version=2}
status=0 QTime=2394
[junit4] 2> 215416 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Wait for recoveries to finish - collection:
streams failOnTimeout:true timeout (sec):30
[junit4] 2> 215417 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.AbstractDistribZkTestBase Recoveries finished - collection: streams
[junit4] 2> 215427 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testMergeStream
[junit4] 2> 215433 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215433 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 215433 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215433 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712069337088),commit=} 0 4
[junit4] 2> 215438 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219712075628544), 2 (1547219712078774272), 3 (1547219712078774273), 4
(1547219712078774274), 1 (1547219712078774275)]} 0 2
[junit4] 2> 215438 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215438 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 215477 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1694fef[streams_shard1_replica1]
main]
[junit4] 2> 215477 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215478 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@1694fef[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(7.0.0):C5)))}
[junit4] 2> 215478 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 39
[junit4] 2> 215483 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215492 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(4+1)&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&wt=json&version=2.2}
hits=2 status=0 QTime=5
[junit4] 2> 215499 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215503 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(0+2+3)&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&wt=json&version=2.2}
hits=3 status=0 QTime=0
[junit4] 2> 215505 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860006, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215506 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860007, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215511 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215516 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(4+1)&distrib=false&fl=id,a_s,a_i&sort=a_i+desc&wt=json&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> 215519 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215526 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(0+2+3)&distrib=false&fl=id,a_s,a_i&sort=a_i+desc&wt=json&version=2.2}
hits=3 status=0 QTime=0
[junit4] 2> 215528 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860008, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215530 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860009, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215535 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215546 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(2+4+1)&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> 215554 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215566 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(0+3)&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> 215568 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c86000a, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215573 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c86000b, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215697 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215703 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(2+4+1)&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc,a_i+desc&wt=json&version=2.2}
hits=3 status=0 QTime=0
[junit4] 2> 215714 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215719 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(0+3)&distrib=false&fl=id,a_s,a_i,a_f&sort=a_f+asc,a_i+desc&wt=json&version=2.2}
hits=2 status=0 QTime=0
[junit4] 2> 215723 INFO
(TEST-StreamingTest.testMergeStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testMergeStream
[junit4] 2> 215733 INFO
(TEST-StreamingTest.testNonePartitionKeys-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testNonePartitionKeys
[junit4] 2> 215739 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@27f489[streams_shard1_replica1]
realtime]
[junit4] 2> 215739 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215739 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 215741 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@145cae9[streams_shard1_replica1]
main]
[junit4] 2> 215741 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@145cae9[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 215744 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215748 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712390201344),commit=} 0 12
[junit4] 2> 215753 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219712405929984), 2 (1547219712409075712), 3 (1547219712409075713), 4
(1547219712409075714), 1 (1547219712409075715), 5 (1547219712409075716), 6
(1547219712409075717), 7 (1547219712409075718), 8 (1547219712409075719), 9
(1547219712409075720)]} 0 3
[junit4] 2> 215754 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215754 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 215775 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@20e9ce[streams_shard1_replica1]
main]
[junit4] 2> 215775 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@20e9ce[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_1(7.0.0):C10)))}
[junit4] 2> 215775 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215775 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 21
[junit4] 2> 215782 INFO
(TEST-StreamingTest.testNonePartitionKeys-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215785 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/stream
params={distrib=false&workerID=0&numWorkers=1&expr=search(streams,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_s+asc,a_f+asc",partitionKeys%3Dnone,zkHost%3D"127.0.0.1:63225/solr")&wt=json&version=2.2}
status=0 QTime=0
[junit4] 2> 215790 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215794 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_s+asc,a_f+asc&partitionKeys=none&wt=json&version=2.2}
hits=10 status=0 QTime=0
[junit4] 2> 215801 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c86000e, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215802 INFO
(TEST-StreamingTest.testNonePartitionKeys-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testNonePartitionKeys
[junit4] 2> 215816 INFO
(TEST-StreamingTest.testSpacesInParams-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testSpacesInParams
[junit4] 2> 215822 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1757ea2[streams_shard1_replica1]
realtime]
[junit4] 2> 215822 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215822 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 215839 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@134f426[streams_shard1_replica1]
main]
[junit4] 2> 215849 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215849 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@134f426[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 215885 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712476184576),commit=} 0 67
[junit4] 2> 215885 INFO
(TEST-StreamingTest.testSpacesInParams-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testSpacesInParams
[junit4] 2> 215897 INFO
(TEST-StreamingTest.testParallelReducerStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testParallelReducerStream
[junit4] 2> 215901 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215901 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 No uncommitted changes. Skipping IW.commit.
[junit4] 2> 215901 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215901 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712562167808),commit=} 0 2
[junit4] 2> 215905 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219712566362112), 2 (1547219712567410688), 3 (1547219712568459264), 4
(1547219712568459265), 1 (1547219712568459266), 5 (1547219712568459267), 6
(1547219712568459268), 7 (1547219712568459269), 8 (1547219712568459270), 9
(1547219712568459271)]} 0 2
[junit4] 2> 215906 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 215906 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 215946 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@63d869[streams_shard1_replica1]
main]
[junit4] 2> 215946 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@63d869[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(7.0.0):C10)))}
[junit4] 2> 215947 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 215947 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 41
[junit4] 2> 215953 INFO
(TEST-StreamingTest.testParallelReducerStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215958 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/stream
params={distrib=false&workerID=0&numWorkers=1&expr=reduce(search(streams,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_s+asc,a_f+asc",partitionKeys%3Da_s,zkHost%3D"127.0.0.1:63225/solr"),by%3Da_s,group(n%3D5,sort%3D"a_f+desc"))&wt=json&version=2.2}
status=0 QTime=0
[junit4] 2> 215962 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_s+asc,a_f+asc&partitionKeys=a_s&fq={!hash+workers%3D1+worker%3D0}&wt=json&version=2.2}
hits=10 status=0 QTime=0
[junit4] 2> 215965 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860010, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 215974 INFO
(TEST-StreamingTest.testParallelReducerStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 215981 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/stream
params={distrib=false&workerID=0&numWorkers=1&expr=reduce(search(streams,q%3D"*:*",fl%3D"id,a_s,a_i,a_f",sort%3D"a_s+desc,a_f+asc",partitionKeys%3Da_s,zkHost%3D"127.0.0.1:63225/solr"),by%3Da_s,group(n%3D3,sort%3D"a_f+asc"))&wt=json&version=2.2}
status=0 QTime=0
[junit4] 2> 215998 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f&sort=a_s+desc,a_f+asc&partitionKeys=a_s&fq={!hash+workers%3D1+worker%3D0}&wt=json&version=2.2}
hits=10 status=0 QTime=2
[junit4] 2> 216003 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860011, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 216004 INFO
(TEST-StreamingTest.testParallelReducerStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testParallelReducerStream
[junit4] 2> 216023 INFO
(TEST-StreamingTest.testStatsStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testStatsStream
[junit4] 2> 216028 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@495fad[streams_shard1_replica1]
realtime]
[junit4] 2> 216028 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216028 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216031 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@78ed86[streams_shard1_replica1]
main]
[junit4] 2> 216031 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@78ed86[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 216031 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216032 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712695336960),commit=} 0 6
[junit4] 2> 216036 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219712702676992), 2 (1547219712704774144), 3 (1547219712704774145), 4
(1547219712704774146), 1 (1547219712704774147), 5 (1547219712704774148), 6
(1547219712704774149), 7 (1547219712704774150), 8 (1547219712705822720), 9
(1547219712705822721)]} 0 2
[junit4] 2> 216037 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216037 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216252 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@3fa691[streams_shard1_replica1]
main]
[junit4] 2> 216253 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@3fa691[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_3(7.0.0):C10)))}
[junit4] 2> 216253 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216253 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 215
[junit4] 2> 216260 INFO
(TEST-StreamingTest.testStatsStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 216265 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&_stateVer_=streams:3&stats=true&rows=0&wt=javabin&version=2&stats.field={!sum%3Dtrue+min%3Dtrue+max%3Dtrue+mean%3Dtrue+}a_f&stats.field={!sum%3Dtrue+min%3Dtrue+max%3Dtrue+mean%3Dtrue+}a_i}
hits=10 status=0 QTime=1
[junit4] 2> 216266 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860012, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 216266 INFO
(TEST-StreamingTest.testStatsStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testStatsStream
[junit4] 2> 216280 INFO
(TEST-StreamingTest.testParallelEOF-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testParallelEOF
[junit4] 2> 216283 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@10c2187[streams_shard1_replica1]
realtime]
[junit4] 2> 216283 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216283 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216285 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@fcbe6d[streams_shard1_replica1]
main]
[junit4] 2> 216286 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@fcbe6d[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 216286 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216287 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219712963772416),commit=} 0 5
[junit4] 2> 216293 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219712970063872), 2 (1547219712974258176), 3 (1547219712974258177), 4
(1547219712974258178), 1 (1547219712974258179), 5 (1547219712974258180), 6
(1547219712975306752), 7 (1547219712975306753), 8 (1547219712975306754), 9
(1547219712975306755)]} 0 3
[junit4] 2> 216294 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216294 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216325 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1f93801[streams_shard1_replica1]
main]
[junit4] 2> 216325 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@1f93801[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(7.0.0):C10)))}
[junit4] 2> 216326 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216326 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 33
[junit4] 2> 216335 INFO
(TEST-StreamingTest.testParallelEOF-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 216363 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/stream
params={distrib=false&workerID=0&numWorkers=1&expr=merge(search(streams,q%3D"id:(4+1+8+7+9)",fl%3D"id,a_s,a_i",sort%3D"a_i+asc",partitionKeys%3Da_i,zkHost%3D"127.0.0.1:63225/solr"),search(streams,q%3D"id:(0+2+3+6)",fl%3D"id,a_s,a_i",sort%3D"a_i+asc",partitionKeys%3Da_i,zkHost%3D"127.0.0.1:63225/solr"),on%3D"a_i+asc")&wt=json&version=2.2}
status=0 QTime=0
[junit4] 2> 216365 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(4+1+8+7+9)&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D1+worker%3D0}&wt=json&version=2.2}
hits=5 status=0 QTime=0
[junit4] 2> 216373 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=id:(0+2+3+6)&distrib=false&fl=id,a_s,a_i&sort=a_i+asc&partitionKeys=a_i&fq={!hash+workers%3D1+worker%3D0}&wt=json&version=2.2}
hits=4 status=0 QTime=5
[junit4] 2> 216379 INFO
(TEST-StreamingTest.testParallelEOF-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testParallelEOF
[junit4] 2> 216400 INFO
(TEST-StreamingTest.testTuple-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testTuple
[junit4] 2> 216402 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1b017b5[streams_shard1_replica1]
realtime]
[junit4] 2> 216403 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216403 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216405 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1853ec9[streams_shard1_replica1]
main]
[junit4] 2> 216406 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@1853ec9[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 216408 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216409 INFO (qtp25156384-2315) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219713089601536),commit=} 0 7
[junit4] 2> 216413 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update params={_stateVer_=streams:3&wt=javabin&version=2}{add=[0
(1547219713097990144)]} 0 2
[junit4] 2> 216413 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216413 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216434 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@1ae9650[streams_shard1_replica1]
main]
[junit4] 2> 216435 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@1ae9650[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(7.0.0):C1)))}
[junit4] 2> 216437 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216437 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{commit=} 0 23
[junit4] 2> 216446 INFO
(TEST-StreamingTest.testTuple-seed#[6833755DB9F64C78]) [ ]
o.a.s.c.c.ZkStateReader Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 216453 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&fl=id,a_s,a_i,a_f,s_multi,i_multi,f_multi&sort=a_s+asc&wt=json&version=2.2}
hits=1 status=0 QTime=0
[junit4] 2> 216454 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860014, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 216455 INFO
(TEST-StreamingTest.testTuple-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Ending testTuple
[junit4] 2> 216471 INFO
(TEST-StreamingTest.testDaemonTopicStream-seed#[6833755DB9F64C78]) [ ]
o.a.s.SolrTestCaseJ4 ###Starting testDaemonTopicStream
[junit4] 2> 216477 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@17b6470[streams_shard1_replica1]
realtime]
[junit4] 2> 216477 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 start
commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 216477 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.SolrIndexWriter Calling setCommitData with
IW:org.apache.solr.update.SolrIndexWriter@137dea8
[junit4] 2> 216479 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.s.SolrIndexSearcher Opening [Searcher@16288fd[streams_shard1_replica1]
main]
[junit4] 2> 216479 INFO
(searcherExecutor-502-thread-1-processing-n:127.0.0.1:63229_solr
x:streams_shard1_replica1 s:shard1 c:streams r:core_node1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1]
Registered new searcher Searcher@16288fd[streams_shard1_replica1]
main{ExitableDirectoryReader(UninvertingDirectoryReader())}
[junit4] 2> 216480 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.DirectUpdateHandler2 end_commit_flush
[junit4] 2> 216481 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1]
o.a.s.u.p.LogUpdateProcessorFactory [streams_shard1_replica1] webapp=/solr
path=/update
params={_stateVer_=streams:3&commit=true&wt=javabin&version=2}{deleteByQuery=*:*
(-1547219713166147584),commit=} 0 6
[junit4] 2> 216485 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216488 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216490 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216492 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216493 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216497 INFO (qtp25156384-2311) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216499 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216501 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216503 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216504 INFO (Thread-291) [ ] o.a.s.c.c.ZkStateReader
Updated live nodes from ZooKeeper... (0) -> (1)
[junit4] 2> 216505 INFO (qtp25156384-2308) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216506 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216508 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={qt=/get&ids=50000000&wt=javabin&version=2} status=0 QTime=0
[junit4] 2> 216509 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216509 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/select
params={q=*:*&distrib=false&sort=_version_+desc&rows=1&wt=json&version=2.2}
hits=0 status=0 QTime=0
[junit4] 2> 216511 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216513 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=1
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216517 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216522 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216525 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216527 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216531 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216533 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216535 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216551 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216553 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216554 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216558 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216560 INFO (qtp25156384-2317) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216562 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216564 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216566 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216569 INFO (qtp25156384-2313) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216570 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216573 INFO (qtp25156384-2319) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216575 INFO (qtp25156384-2312) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216577 INFO (qtp25156384-2314) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216579 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216584 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216585 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216587 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216590 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216591 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216594 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216596 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216598 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216599 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216601 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216603 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216606 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:streams_shard1_replica1] o.a.s.c.S.Request
[streams_shard1_replica1] webapp=/solr path=/get
params={fl=id&ids=50000000&wt=json&version=2.2} status=0 QTime=0
[junit4] 1> ###### Waiting for checkpoint #######:0
[junit4] 2> 216608 INFO (qtp25156384-2310) [n:127.0.0.1:63229_solr
c:streams s:shard1 r:core_node1 x:s
[...truncated too long message...]
9F64C78]) [ ] o.a.s.SolrTestCaseJ4 ###Ending testRankStream
[junit4] 2> 219895 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860005, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 219898 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.ServerConnector Stopped
ServerConnector@9c8a06{HTTP/1.1,[http/1.1]}{127.0.0.1:0}
[junit4] 2> 219898 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.c.CoreContainer Shutting down CoreContainer instance=29001948
[junit4] 2> 219900 INFO (coreCloseExecutor-507-thread-1)
[n:127.0.0.1:63229_solr c:streams s:shard1 r:core_node1
x:streams_shard1_replica1] o.a.s.c.SolrCore [streams_shard1_replica1] CLOSING
SolrCore org.apache.solr.core.SolrCore@9be256
[junit4] 2> 219902 INFO
(zkCallback-767-thread-1-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader A cluster state change:
[WatchedEvent state:SyncConnected type:NodeDataChanged
path:/collections/streams/state.json] for collection [streams] has occurred -
updating... (live nodes size: [1])
[junit4] 2> 219912 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c86000f, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 219913 INFO (jetty-launcher-761-thread-1) [ ]
o.a.s.c.Overseer Overseer
(id=96701231829221379-127.0.0.1:63229_solr-n_0000000000) closing
[junit4] 2> 219913 INFO
(OverseerStateUpdate-96701231829221379-127.0.0.1:63229_solr-n_0000000000)
[n:127.0.0.1:63229_solr ] o.a.s.c.Overseer Overseer Loop exiting :
127.0.0.1:63229_solr
[junit4] 2> 219916 WARN (NIOServerCxn.Factory:0.0.0.0/0.0.0.0:0) [ ]
o.a.z.s.NIOServerCnxn caught end of stream exception
[junit4] 2> EndOfStreamException: Unable to read additional data from
client sessionid 0x1578d420c860003, likely client has closed socket
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228)
[junit4] 2> at
org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208)
[junit4] 2> at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 219917 WARN
(zkCallback-767-thread-1-processing-n:127.0.0.1:63229_solr)
[n:127.0.0.1:63229_solr ] o.a.s.c.c.ZkStateReader ZooKeeper watch triggered,
but Solr cannot talk to ZK: [KeeperErrorCode = Session expired for /live_nodes]
[junit4] 2> 219918 INFO (jetty-launcher-761-thread-1) [ ]
o.e.j.s.h.ContextHandler Stopped
o.e.j.s.ServletContextHandler@17cbfb0{/solr,null,UNAVAILABLE}
[junit4] 2> 219920 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.c.ZkTestServer connecting to 127.0.0.1:63225 63225
[junit4] 2> 219922 INFO (Thread-278) [ ] o.a.s.c.ZkTestServer
connecting to 127.0.0.1:63225 63225
[junit4] 2> 219923 WARN (Thread-278) [ ] o.a.s.c.ZkTestServer Watch
limit violations:
[junit4] 2> Maximum concurrent create/delete watches above limit:
[junit4] 2>
[junit4] 2> 53 /solr/aliases.json
[junit4] 2> 53 /solr/clusterprops.json
[junit4] 2>
[junit4] 2> Maximum concurrent data watches above limit:
[junit4] 2>
[junit4] 2> 53 /solr/clusterstate.json
[junit4] 2>
[junit4] 2> Maximum concurrent children watches above limit:
[junit4] 2>
[junit4] 2> 53 /solr/live_nodes
[junit4] 2> 53 /solr/collections
[junit4] 2> 7 /solr/overseer/queue
[junit4] 2> 7 /solr/overseer/collection-queue-work
[junit4] 2> 2 /solr/overseer/queue-work
[junit4] 2>
[junit4] 2> 219923 INFO
(SUITE-StreamingTest-seed#[6833755DB9F64C78]-worker) [ ]
o.a.s.SolrTestCaseJ4 ###deleteCore
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene62):
{multiDefault=PostingsFormat(name=Memory doPackFST= true),
a_f=PostingsFormat(name=Memory doPackFST= true),
intDefault=PostingsFormat(name=LuceneVarGapFixedInterval),
a_i=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
dt_sing=PostingsFormat(name=LuceneVarGapFixedInterval),
level1_s=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
dt_multi=PostingsFormat(name=LuceneVarGapFixedInterval),
s_multi=Lucene50(blocksize=128),
l_multi=PostingsFormat(name=LuceneVarGapFixedInterval),
a_ss=PostingsFormat(name=LuceneVarGapFixedInterval),
level2_s=PostingsFormat(name=LuceneVarGapFixedInterval),
a_s=Lucene50(blocksize=128),
id=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
d_multi=PostingsFormat(name=LuceneVarGapFixedInterval),
timestamp=PostingsFormat(name=LuceneVarGapFixedInterval),
d_sing=PostingsFormat(name=LuceneVarGapFixedInterval),
i_multi=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
b_sing=PostingsFormat(name=Memory doPackFST= true),
b_multi=PostingsFormat(name=Memory doPackFST= true),
checkpoint_ss=Lucene50(blocksize=128), f_multi=PostingsFormat(name=Memory
doPackFST= true), _version_=PostingsFormat(name=LuceneVarGapFixedInterval),
f_sing=PostingsFormat(name=Memory doPackFST= true),
s_sing=Lucene50(blocksize=128),
i_sing=TestBloomFilteredLucenePostings(BloomFilteringPostingsFormat(Lucene50(blocksize=128))),
l_sing=PostingsFormat(name=LuceneVarGapFixedInterval)},
docValues:{i_multi=DocValuesFormat(name=Direct),
multiDefault=DocValuesFormat(name=Asserting),
b_sing=DocValuesFormat(name=Asserting), a_f=DocValuesFormat(name=Asserting),
intDefault=DocValuesFormat(name=Lucene54),
b_multi=DocValuesFormat(name=Asserting), a_i=DocValuesFormat(name=Direct),
checkpoint_ss=DocValuesFormat(name=Memory),
f_multi=DocValuesFormat(name=Asserting),
dt_sing=DocValuesFormat(name=Lucene54), level1_s=DocValuesFormat(name=Direct),
dt_multi=DocValuesFormat(name=Lucene54), s_multi=DocValuesFormat(name=Memory),
l_multi=DocValuesFormat(name=Lucene54), a_ss=DocValuesFormat(name=Lucene54),
level2_s=DocValuesFormat(name=Lucene54), a_s=DocValuesFormat(name=Memory),
f_sing=DocValuesFormat(name=Asserting), s_sing=DocValuesFormat(name=Memory),
i_sing=DocValuesFormat(name=Direct), l_sing=DocValuesFormat(name=Lucene54),
id=DocValuesFormat(name=Direct), d_multi=DocValuesFormat(name=Lucene54),
d_sing=DocValuesFormat(name=Lucene54)}, maxPointsInLeafNode=848,
maxMBSortInHeap=6.374246686848111, sim=ClassicSimilarity, locale=ar-IQ,
timezone=America/Kralendijk
[junit4] 2> NOTE: Windows 10 10.0 x86/Oracle Corporation 1.8.0_102
(32-bit)/cpus=3,threads=1,free=149759208,total=246677504
[junit4] 2> NOTE: All tests run in this JVM: [SolrPingTest,
TestZkConfigManager, ConcurrentUpdateSolrClientBuilderTest,
BasicHttpSolrClientTest, GetByIdTest, SolrExceptionTest,
DocumentAnalysisResponseTest, SolrZkClientTest, StreamExpressionTest,
SolrQueryTest, TestConfigSetAdminRequest, SolrParamTest,
StreamExpressionParserTest, TestLBHttpSolrClient, MergeIndexesEmbeddedTest,
SolrExampleJettyTest, ContentStreamTest, ClientUtilsTest,
TestSuggesterResponse, TestClusteringResponse, SolrExampleBinaryTest,
LargeVolumeBinaryJettyTest, TestBatchUpdate, JettyWebappTest,
TestSpellCheckResponse, QueryResponseTest, TestNamedListCodec,
TestJavaBinCodec, TestDocumentObjectBinder, ModifiableSolrParamsTest,
SolrDocumentTest, FacetFieldTest, SolrSchemalessExampleTest,
CloudSolrClientBuilderTest, StreamExpressionToExpessionTest,
StreamExpressionToExplanationTest, StreamingTest]
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=StreamingTest
-Dtests.seed=6833755DB9F64C78 -Dtests.slow=true -Dtests.locale=ar-IQ
-Dtests.timezone=America/Kralendijk -Dtests.asserts=true
-Dtests.file.encoding=Cp1252
[junit4] ERROR 0.00s J1 | StreamingTest (suite) <<<
[junit4] > Throwable #1: java.lang.AssertionError: ObjectTracker found 1
object(s) that were not released!!! [InternalHttpClient]
[junit4] >
org.apache.solr.common.util.ObjectReleaseTracker$ObjectTrackerException
[junit4] > at
org.apache.solr.common.util.ObjectReleaseTracker.track(ObjectReleaseTracker.java:43)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:262)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:209)
[junit4] > at
org.apache.solr.client.solrj.impl.HttpClientUtil.createClient(HttpClientUtil.java:201)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:393)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient.<init>(CloudSolrClient.java:100)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClient$Builder.build(CloudSolrClient.java:1673)
[junit4] > at
org.apache.solr.client.solrj.impl.CloudSolrClientBuilderTest.testNoZkHostSpecified(CloudSolrClientBuilderTest.java:36)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] > at
__randomizedtesting.SeedInfo.seed([6833755DB9F64C78]:0)
[junit4] > at
org.apache.solr.SolrTestCaseJ4.teardownTestCases(SolrTestCaseJ4.java:261)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] Completed [85/85 (2!)] on J1 in 38.24s, 27 tests, 1 failure, 2
skipped <<< FAILURES!
[...truncated 51923 lines...]
---------------------------------------------------------------------
To unsubscribe, e-mail: [email protected]
For additional commands, e-mail: [email protected]
