You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/06/13 00:58:26 UTC
[JENKINS] Lucene-Solr-4.x-Windows (64bit/jdk1.6.0_45) - Build #
2885 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/2885/
Java: 64bit/jdk1.6.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest.testGetEmptyResults
Error Message:
IOException occured when talking to server at: https://127.0.0.1:53290/solr/collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:53290/solr/collection1
at __randomizedtesting.SeedInfo.seed([66671C7DCD44BD4C:3DA60D63F9C3D946]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer.request(ConcurrentUpdateSolrServer.java:256)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
at org.apache.solr.client.solrj.SolrExampleTests.testGetEmptyResults(SolrExampleTests.java:279)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
at java.lang.reflect.Method.invoke(Method.java:597)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:662)
Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
... 46 more
Build Log:
[...truncated 9857 lines...]
[junit4:junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest
[junit4:junit4] 1> 27175 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] WARN org.apache.solr.SolrTestCaseJ4 ? startTrackingSearchers: numOpens=15 numCloses=15
[junit4:junit4] 1> 27175 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.SolrJettyTestBase ? Randomized ssl (true) and clientAuth (false)
[junit4:junit4] 1> 27176 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.SolrTestCaseJ4 ? ####initCore
[junit4:junit4] 1> 27179 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.SolrTestCaseJ4 ? ####initCore end
[junit4:junit4] 1> 27179 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.eclipse.jetty.server.Server ? jetty-8.1.10.v20130312
[junit4:junit4] 1> 27190 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.eclipse.jetty.util.ssl.SslContextFactory ? Enabled Protocols [SSLv2Hello, SSLv3, TLSv1] of [SSLv2Hello, SSLv3, TLSv1]
[junit4:junit4] 1> 27195 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.eclipse.jetty.server.AbstractConnector ? Started SslSelectChannelConnector@127.0.0.1:53290
[junit4:junit4] 1> 27211 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter ? SolrDispatchFilter.init()
[junit4:junit4] 1> 27212 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrResourceLoader ? JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 1> 27212 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrResourceLoader ? using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr
[junit4:junit4] 1> 27214 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CoreContainer ? looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\solr.xml
[junit4:junit4] 1> 27214 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CoreContainer ? New CoreContainer 1597843551
[junit4:junit4] 1> 27215 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CoreContainer ? Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\'
[junit4:junit4] 1> 27216 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrResourceLoader ? new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\'
[junit4:junit4] 1> 27371 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr
[junit4:junit4] 1> 27372 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn
[junit4:junit4] 1> 27378 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\prop-base
[junit4:junit4] 1> 27384 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\props
[junit4:junit4] 1> 27386 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\text-base
[junit4:junit4] 1> 27391 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\tmp
[junit4:junit4] 1> 27394 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\tmp\prop-base
[junit4:junit4] 1> 27396 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\tmp\props
[junit4:junit4] 1> 27397 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\.svn\tmp\text-base
[junit4:junit4] 1> 27399 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin
[junit4:junit4] 1> 27402 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn
[junit4:junit4] 1> 27408 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\prop-base
[junit4:junit4] 1> 27410 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\props
[junit4:junit4] 1> 27411 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\text-base
[junit4:junit4] 1> 27412 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\tmp
[junit4:junit4] 1> 27413 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\tmp\prop-base
[junit4:junit4] 1> 27415 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\tmp\props
[junit4:junit4] 1> 27419 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\bin\.svn\tmp\text-base
[junit4:junit4] 1> 27419 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer ? Discovered properties file C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\core.properties, adding to cores
[junit4:junit4] 1> 27424 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting socketTimeout to: 0
[junit4:junit4] 1> 27424 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting urlScheme to: http://
[junit4:junit4] 1> 27424 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting connTimeout to: 0
[junit4:junit4] 1> 27425 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting maxConnectionsPerHost to: 20
[junit4:junit4] 1> 27425 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting corePoolSize to: 0
[junit4:junit4] 1> 27426 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting maximumPoolSize to: 2147483647
[junit4:junit4] 1> 27427 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting maxThreadIdleTime to: 5
[junit4:junit4] 1> 27428 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting sizeOfQueue to: -1
[junit4:junit4] 1> 27428 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory ? Setting fairnessPolicy to: false
[junit4:junit4] 1> 27429 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.client.solrj.impl.HttpClientUtil ? Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4] 1> 27438 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.logging.LogWatcher ? Registering Log Listener
[junit4:junit4] 1> 27444 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.CoreContainer ? Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1
[junit4:junit4] 1> 27445 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrResourceLoader ? new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\'
[junit4:junit4] 1> 27488 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrConfig ? Adding specified lib dirs to ClassLoader
[junit4:junit4] 1> 27490 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? No files added to classloader from lib: ../../../contrib/extraction/lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\contrib\extraction\lib).
[junit4:junit4] 1> 27490 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4] 1> 27492 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? No files added to classloader from lib: ../../../contrib/clustering/lib/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\contrib\clustering\lib).
[junit4:junit4] 1> 27493 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4] 1> 27493 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? No files added to classloader from lib: ../../../contrib/langid/lib/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\contrib\langid\lib).
[junit4:junit4] 1> 27495 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4] 1> 27496 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? No files added to classloader from lib: ../../../contrib/velocity/lib (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\contrib\velocity\lib).
[junit4:junit4] 1> 27496 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrResourceLoader ? Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4] 1> 27574 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrConfig ? Using Lucene MatchVersion: LUCENE_43
[junit4:junit4] 1> 27787 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.Config ? Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 1> 27789 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.schema.IndexSchema ? Reading Solr Schema from schema.xml
[junit4:junit4] 1> 27997 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.schema.IndexSchema ? [collection1] Schema name=example
[junit4:junit4] 1> 28992 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.schema.IndexSchema ? unique key field: id
[junit4:junit4] 1> 29020 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider ? Reloading exchange rates from file currency.xml
[junit4:junit4] 1> 29028 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider ? Reloading exchange rates from file currency.xml
[junit4:junit4] 1> 29125 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 1> 29126 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\
[junit4:junit4] 1> 29126 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.JmxMonitoredMap ? JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@7cf01771
[junit4:junit4] 1> 29127 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4] 1> 29127 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4:junit4] 1> 29127 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 1> 29128 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.CachingDirectoryFactory ? return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\
[junit4:junit4] 1> 29128 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index/
[junit4:junit4] 1> 29129 [coreLoadExecutor-59-thread-1] WARN org.apache.solr.core.SolrCore ? [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index' doesn't exist. Creating new index...
[junit4:junit4] 1> 29129 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.CachingDirectoryFactory ? return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index
[junit4:junit4] 1> 29132 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1,generation=1}
[junit4:junit4] 1> 29133 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? newest commit generation = 1
[junit4:junit4] 1> 29134 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? created json: solr.JSONResponseWriter
[junit4:junit4] 1> 29135 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4:junit4] 1> 29135 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? created velocity: solr.VelocityResponseWriter
[junit4:junit4] 1> 29135 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? created xslt: solr.XSLTResponseWriter
[junit4:junit4] 1> 29135 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.response.XSLTResponseWriter ? xsltCacheLifetimeSeconds=5
[junit4:junit4] 1> 29138 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /select: solr.SearchHandler
[junit4:junit4] 1> 29139 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /query: solr.SearchHandler
[junit4:junit4] 1> 29139 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /get: solr.RealTimeGetHandler
[junit4:junit4] 1> 29141 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /browse: solr.SearchHandler
[junit4:junit4] 1> 29141 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /update: solr.UpdateRequestHandler
[junit4:junit4] 1> 29142 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /update/json: solr.JsonUpdateRequestHandler
[junit4:junit4] 1> 29143 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /update/csv: solr.CSVRequestHandler
[junit4:junit4] 1> 29143 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 1> 29143 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 1> 29144 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4:junit4] 1> 29144 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4:junit4] 1> 29145 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 1> 29145 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 1> 29145 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /admin/: solr.admin.AdminHandlers
[junit4:junit4] 1> 29147 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /admin/ping: solr.PingRequestHandler
[junit4:junit4] 1> 29147 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 1> 29148 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /replication: solr.ReplicationHandler
[junit4:junit4] 1> 29148 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 29149 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /spell: solr.SearchHandler
[junit4:junit4] 1> 29149 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 29149 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /tvrh: solr.SearchHandler
[junit4:junit4] 1> 29149 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 29150 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /terms: solr.SearchHandler
[junit4:junit4] 1> 29151 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 29151 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.RequestHandlers ? created /elevate: solr.SearchHandler
[junit4:junit4] 1> 29160 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.loader.XMLLoader ? xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 29163 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.loader.XMLLoader ? xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 29165 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.loader.XMLLoader ? xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 29270 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@5af92541 main
[junit4:junit4] 1> 29270 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.update.UpdateHandler ? Clearing tlog files, tlogDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\tlog
[junit4:junit4] 1> 29271 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? Hard AutoCommit: if uncommited for 15000ms;
[junit4:junit4] 1> 29271 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.SolrCore ? Soft AutoCommit: disabled
[junit4:junit4] 1> 29272 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent ? Initializing spell checkers
[junit4:junit4] 1> 29273 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.spelling.DirectSolrSpellChecker ? init: {name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4:junit4] 1> 29273 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent ? No queryConverter defined, using default converter
[junit4:junit4] 1> 29276 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.component.QueryElevationComponent ? Loading QueryElevation from: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\example\solr\collection1\conf\elevate.xml
[junit4:junit4] 1> 29304 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.handler.ReplicationHandler ? Commits will be reserved for 10000
[junit4:junit4] 1> 29311 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@5af92541 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 1> 29313 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=null path=null params={event=firstSearcher&q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false} hits=0 status=0 QTime=1
[junit4:junit4] 1> 29313 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 29313 [searcherExecutor-60-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent ? Loading spell index for spellchecker: default
[junit4:junit4] 1> 29313 [searcherExecutor-60-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent ? Loading spell index for spellchecker: wordbreak
[junit4:junit4] 1> 29314 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@5af92541 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 1> 29318 [coreLoadExecutor-59-thread-1] INFO org.apache.solr.core.CoreContainer ? registering core: collection1
[junit4:junit4] 1> 29321 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter ? user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0
[junit4:junit4] 1> 29321 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter ? SolrDispatchFilter.init() done
[junit4:junit4] 1> 29321 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.SolrJettyTestBase ? Jetty Assigned Port#53290
[junit4:junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\.\solrtest-SolrExampleStreamingBinaryTest-1371077512014
[junit4:junit4] 1> 29333 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdateOrder-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testSetNullUpdateOrder
[junit4:junit4] 1> 29338 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdateOrder-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil ? Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 1> 29358 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4f801c4
[junit4:junit4] 1> 29432 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onInit: commits: num=1
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1,generation=1}
[junit4:junit4] 1> 29433 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 1
[junit4:junit4] 1> 29704 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdateOrder (1437678975597936640)]} 0 281
[junit4:junit4] 1> 29706 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: testSetNullUpdateOrder is 200
[junit4:junit4] 1> 29707 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4f801c4
[junit4:junit4] 1> 29720 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 29724 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1,generation=1}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_2,generation=2}
[junit4:junit4] 1> 29724 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 2
[junit4:junit4] 1> 29725 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@57d62a85 main
[junit4:junit4] 1> 29727 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@57d62a85 main{StandardDirectoryReader(segments_2:3:nrt _0(4.4):C1)}
[junit4:junit4] 1> 29728 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 29727 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 29731 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@57d62a85 main{StandardDirectoryReader(segments_2:3:nrt _0(4.4):C1)}
[junit4:junit4] 1> 29732 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 13
[junit4:junit4] 1> 29734 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@656ad447
[junit4:junit4] 1> 30031 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdateOrder (1437678975925092352)]} 0 292
[junit4:junit4] 1> 30032 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: testSetNullUpdateOrder is 200
[junit4:junit4] 1> 30032 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@656ad447
[junit4:junit4] 1> 30036 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 30041 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_2,generation=2}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_3,generation=3}
[junit4:junit4] 1> 30042 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 3
[junit4:junit4] 1> 30043 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@1441e2aa main
[junit4:junit4] 1> 30046 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@1441e2aa main{StandardDirectoryReader(segments_3:7:nrt _1(4.4):C1)}
[junit4:junit4] 1> 30047 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 30046 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 30049 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@1441e2aa main{StandardDirectoryReader(segments_3:7:nrt _1(4.4):C1)}
[junit4:junit4] 1> 30050 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 14
[junit4:junit4] 1> 30057 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdateOrder&wt=javabin&version=2} hits=1 status=0 QTime=2
[junit4:junit4] 1> 30059 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdateOrder-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testSetNullUpdateOrder
[junit4:junit4] 1> 30073 [TEST-SolrExampleStreamingBinaryTest.testUnicode-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testUnicode
[junit4:junit4] 1> 30084 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7f32e233 realtime
[junit4:junit4] 1> 30084 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678976282656768)} 0 3
[junit4:junit4] 1> 30087 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@65a0c382
[junit4:junit4] 1> 30383 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 (1437678976293142528)]} 0 292
[junit4:junit4] 1> 30384 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 0 is 200
[junit4:junit4] 1> 30384 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@65a0c382
[junit4:junit4] 1> 30389 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 30391 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_3,generation=3}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_4,generation=4}
[junit4:junit4] 1> 30392 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 4
[junit4:junit4] 1> 30393 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@28a50395 main
[junit4:junit4] 1> 30395 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 30395 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@28a50395 main{StandardDirectoryReader(segments_4:11:nrt _2(4.4):C1)}
[junit4:junit4] 1> 30396 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 30398 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@28a50395 main{StandardDirectoryReader(segments_4:11:nrt _2(4.4):C1)}
[junit4:junit4] 1> 30399 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4:junit4] 1> 30406 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=1} hits=1 status=0 QTime=2
[junit4:junit4] 1> 30414 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@443ad545 realtime
[junit4:junit4] 1> 30415 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678976629735424)} 0 3
[junit4:junit4] 1> 30416 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7287c801
[junit4:junit4] 1> 30715 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 (1437678976639172608), 1 (1437678976640221184)]} 0 294
[junit4:junit4] 1> 30716 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 0 is 200
[junit4:junit4] 1> 30716 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7287c801
[junit4:junit4] 1> 30721 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 30723 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_4,generation=4}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_5,generation=5}
[junit4:junit4] 1> 30724 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 5
[junit4:junit4] 1> 30725 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@456e3eb3 main
[junit4:junit4] 1> 30728 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 30728 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@456e3eb3 main{StandardDirectoryReader(segments_5:15:nrt _3(4.4):C2)}
[junit4:junit4] 1> 30728 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 30731 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@456e3eb3 main{StandardDirectoryReader(segments_5:15:nrt _3(4.4):C2)}
[junit4:junit4] 1> 30891 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 171
[junit4:junit4] 1> 30895 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=2} hits=2 status=0 QTime=1
[junit4:junit4] 1> 30902 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@116dd645 realtime
[junit4:junit4] 1> 30903 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678977141440512)} 0 3
[junit4:junit4] 1> 30906 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@420e54f3
[junit4:junit4] 1> 31201 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 (1437678977150877696), 1 (1437678977151926272), 2 (1437678977152974848), 3 (1437678977152974849), 4 (1437678977152974850), 5 (1437678977154023424), 6 (1437678977154023425), 7 (1437678977154023426), 8 (1437678977154023427)]} 0 292
[junit4:junit4] 1> 31204 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 0 is 200
[junit4:junit4] 1> 31204 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@420e54f3
[junit4:junit4] 1> 31209 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 31216 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_5,generation=5}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_6,generation=6}
[junit4:junit4] 1> 31217 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 6
[junit4:junit4] 1> 31219 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7d94a8eb main
[junit4:junit4] 1> 31221 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 31221 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@7d94a8eb main{StandardDirectoryReader(segments_6:19:nrt _4(4.4):C9)}
[junit4:junit4] 1> 31223 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 31226 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@7d94a8eb main{StandardDirectoryReader(segments_6:19:nrt _4(4.4):C9)}
[junit4:junit4] 1> 31227 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 18
[junit4:junit4] 1> 31234 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=9} hits=9 status=0 QTime=1
[junit4:junit4] 1> 31245 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@780eb73e realtime
[junit4:junit4] 1> 31248 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678977501102080)} 0 6
[junit4:junit4] 1> 31250 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@e208506
[junit4:junit4] 1> 31548 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 (1437678977513684992), 1 (1437678977514733568), 2 (1437678977514733569), 3 (1437678977515782144), 4 (1437678977515782145)]} 0 295
[junit4:junit4] 1> 31550 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 0 is 200
[junit4:junit4] 1> 31550 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@e208506
[junit4:junit4] 1> 31555 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 31558 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_6,generation=6}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_7,generation=7}
[junit4:junit4] 1> 31558 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 7
[junit4:junit4] 1> 31559 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@503d58b2 main
[junit4:junit4] 1> 31561 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 31561 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@503d58b2 main{StandardDirectoryReader(segments_7:23:nrt _5(4.4):C5)}
[junit4:junit4] 1> 31563 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 31566 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@503d58b2 main{StandardDirectoryReader(segments_7:23:nrt _5(4.4):C5)}
[junit4:junit4] 1> 31568 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 13
[junit4:junit4] 1> 31574 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=5} hits=5 status=0 QTime=1
[junit4:junit4] 1> 31576 [TEST-SolrExampleStreamingBinaryTest.testUnicode-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testUnicode
[junit4:junit4] 1> 31594 [TEST-SolrExampleStreamingBinaryTest.testCommitWithinOnAdd-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testCommitWithinOnAdd
[junit4:junit4] 1> 31602 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@f6ce9df realtime
[junit4:junit4] 1> 31604 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678977875443712)} 0 4
[junit4:junit4] 1> 31610 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 31610 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_7,generation=7}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_8,generation=8}
[junit4:junit4] 1> 31610 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 8
[junit4:junit4] 1> 31612 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@a92fe09 main
[junit4:junit4] 1> 31614 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@a92fe09 main{StandardDirectoryReader(segments_7:25:nrt)}
[junit4:junit4] 1> 31615 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 31614 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 31618 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@a92fe09 main{StandardDirectoryReader(segments_7:25:nrt)}
[junit4:junit4] 1> 31621 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 12
[junit4:junit4] 1> 31625 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 31633 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7b98a1f4
[junit4:junit4] 1> 31636 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 31940 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id3 (1437678977924726784)]} 0 293
[junit4:junit4] 1> 31942 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: id3 is 200
[junit4:junit4] 1> 31942 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7b98a1f4
[junit4:junit4] 1> 32237 [commitScheduler-63-thread-1] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 1> 32246 [commitScheduler-63-thread-1] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@1619b32e main
[junit4:junit4] 1> 32246 [commitScheduler-63-thread-1] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 32246 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@1619b32e main{StandardDirectoryReader(segments_8:27:nrt _6(4.4):C1)}
[junit4:junit4] 1> 32247 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 32250 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@1619b32e main{StandardDirectoryReader(segments_8:27:nrt _6(4.4):C1)}
[junit4:junit4] 1> 32819 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 32823 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7c02dce0
[junit4:junit4] 1> 33124 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id4 (1437678979166240768)]} 0 294
[junit4:junit4] 1> 33127 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: id4 is 200
[junit4:junit4] 1> 33127 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7c02dce0
[junit4:junit4] 1> 33419 [commitScheduler-63-thread-1] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 1> 33439 [commitScheduler-63-thread-1] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@117e72d1 main
[junit4:junit4] 1> 33440 [commitScheduler-63-thread-1] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 33440 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@117e72d1 main{StandardDirectoryReader(segments_8:29:nrt _6(4.4):C1 _7(4.4):C1)}
[junit4:junit4] 1> 33441 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 33448 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@117e72d1 main{StandardDirectoryReader(segments_8:29:nrt _6(4.4):C1 _7(4.4):C1)}
[junit4:junit4] 1> 33998 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:id4&wt=javabin&version=2} hits=1 status=0 QTime=3
[junit4:junit4] 1> 34001 [TEST-SolrExampleStreamingBinaryTest.testCommitWithinOnAdd-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testCommitWithinOnAdd
[junit4:junit4] 1> 34015 [TEST-SolrExampleStreamingBinaryTest.testMultiContentStreamRequest-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testMultiContentStreamRequest
[junit4:junit4] 1> 34021 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@58e38fae realtime
[junit4:junit4] 1> 34022 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678980411949056)} 0 4
[junit4:junit4] 1> 34028 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34030 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_8,generation=8}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_9,generation=9}
[junit4:junit4] 1> 34030 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 9
[junit4:junit4] 1> 34031 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6adc91e2 main
[junit4:junit4] 1> 34031 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34032 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@6adc91e2 main{StandardDirectoryReader(segments_8:31:nrt)}
[junit4:junit4] 1> 34033 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34034 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@6adc91e2 main{StandardDirectoryReader(segments_8:31:nrt)}
[junit4:junit4] 1> 34036 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 8
[junit4:junit4] 1> 34051 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 34260 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34274 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_9,generation=9}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_a,generation=10}
[junit4:junit4] 1> 34274 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 10
[junit4:junit4] 1> 34278 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@371c1463 main
[junit4:junit4] 1> 34279 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34279 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@371c1463 main{StandardDirectoryReader(segments_a:33:nrt _8(4.4):C5)}
[junit4:junit4] 1> 34279 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34282 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@371c1463 main{StandardDirectoryReader(segments_a:33:nrt _8(4.4):C5)}
[junit4:junit4] 1> 34284 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&echoParams=ALL&commit=true&a=?&wt=javabin&version=2&softCommit=false} {add=[SP2514N (1437678980640538624), 6H500F0 (1437678980647878656), TWINX2048-3200PRO (1437678980651024384), VS1GB400C3 (1437678980656267264), VDBDB1A16 (1437678980658364416)],commit=} 0 47
[junit4:junit4] 1> 34289 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=5 status=0 QTime=0
[junit4:junit4] 1> 34300 [TEST-SolrExampleStreamingBinaryTest.testMultiContentStreamRequest-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testMultiContentStreamRequest
[junit4:junit4] 1> 34332 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testWaitOptions
[junit4:junit4] 1> 34333 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil ? Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 1> 34342 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? blocking for commit/optimize
[junit4:junit4] 1> 34379 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34381 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_a,generation=10}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_b,generation=11}
[junit4:junit4] 1> 34382 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 11
[junit4:junit4] 1> 34383 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@64ba3b30 main
[junit4:junit4] 1> 34383 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34386 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@64ba3b30 main{StandardDirectoryReader(segments_b:35:nrt _8(4.4):C5 _9(4.4):C1)}
[junit4:junit4] 1> 34386 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34387 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@64ba3b30 main{StandardDirectoryReader(segments_b:35:nrt _8(4.4):C5 _9(4.4):C1)}
[junit4:junit4] 1> 34389 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {add=[42 (1437678980786290688)],commit=} 0 13
[junit4:junit4] 1> 34390 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? blocking for commit/optimize
[junit4:junit4] 1> 34390 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1d0ca25a
[junit4:junit4] 1> 34401 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34406 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_b,generation=11}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_c,generation=12}
[junit4:junit4] 1> 34407 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 12
[junit4:junit4] 1> 34408 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@607dcb35 main
[junit4:junit4] 1> 34409 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@607dcb35 main{StandardDirectoryReader(segments_c:37:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1)}
[junit4:junit4] 1> 34411 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34417 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@607dcb35 main{StandardDirectoryReader(segments_c:37:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1)}
[junit4:junit4] 1> 34411 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34693 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34696 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_c,generation=12}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_d,generation=13}
[junit4:junit4] 1> 34697 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 13
[junit4:junit4] 1> 34698 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@18b1625c main
[junit4:junit4] 1> 34699 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34701 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=false&commit=true&wt=javabin&version=2&softCommit=false} {add=[43 (1437678980811456512)],commit=,commit=} 0 302
[junit4:junit4] 1> 34700 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@18b1625c main{StandardDirectoryReader(segments_c:37:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1)}
[junit4:junit4] 1> 34704 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34704 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 43 is 200
[junit4:junit4] 1> 34707 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1d0ca25a
[junit4:junit4] 1> 34712 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@18b1625c main{StandardDirectoryReader(segments_c:37:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1)}
[junit4:junit4] 1> 34719 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34727 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_d,generation=13}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_e,generation=14}
[junit4:junit4] 1> 34728 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 14
[junit4:junit4] 1> 34731 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@18145132 main
[junit4:junit4] 1> 34735 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@18145132 main{StandardDirectoryReader(segments_e:39:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1)}
[junit4:junit4] 1> 34735 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34736 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34740 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@18145132 main{StandardDirectoryReader(segments_e:39:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1)}
[junit4:junit4] 1> 34743 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {add=[44 (1437678981141757952)],commit=} 0 29
[junit4:junit4] 1> 34746 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? blocking for commit/optimize
[junit4:junit4] 1> 34747 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5ddeb5f7
[junit4:junit4] 1> 34757 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 34766 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_e,generation=14}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_f,generation=15}
[junit4:junit4] 1> 34766 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 15
[junit4:junit4] 1> 34770 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@71933d6c main
[junit4:junit4] 1> 34773 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@71933d6c main{StandardDirectoryReader(segments_f:41:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1 _c(4.4):C1)}
[junit4:junit4] 1> 34773 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 34773 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 34776 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@71933d6c main{StandardDirectoryReader(segments_f:41:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1 _c(4.4):C1)}
[junit4:junit4] 1> 35045 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35048 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_f,generation=15}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_g,generation=16}
[junit4:junit4] 1> 35049 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 16
[junit4:junit4] 1> 35052 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@227c808d main
[junit4:junit4] 1> 35053 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35054 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@227c808d main{StandardDirectoryReader(segments_f:41:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1 _c(4.4):C1)}
[junit4:junit4] 1> 35055 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=false&commit=true&wt=javabin&version=2&softCommit=false} {add=[45 (1437678981183700992)],commit=,commit=} 0 301
[junit4:junit4] 1> 35055 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35058 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 45 is 200
[junit4:junit4] 1> 35068 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5ddeb5f7
[junit4:junit4] 1> 35072 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@227c808d main{StandardDirectoryReader(segments_f:41:nrt _8(4.4):C5 _9(4.4):C1 _a(4.4):C1 _b(4.4):C1 _c(4.4):C1)}
[junit4:junit4] 1> 35081 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35118 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_g,generation=16}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_h,generation=17}
[junit4:junit4] 1> 35119 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 17
[junit4:junit4] 1> 35122 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@32fbca58 main
[junit4:junit4] 1> 35123 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@32fbca58 main{StandardDirectoryReader(segments_h:45:nrt _e(4.4):C10)}
[junit4:junit4] 1> 35123 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35125 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35127 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@32fbca58 main{StandardDirectoryReader(segments_h:45:nrt _e(4.4):C10)}
[junit4:junit4] 1> 35129 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {add=[46 (1437678981521342464)],optimize=} 0 53
[junit4:junit4] 1> 35131 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? blocking for commit/optimize
[junit4:junit4] 1> 35131 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@30a1718e
[junit4:junit4] 1> 35137 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35159 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_h,generation=17}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_i,generation=18}
[junit4:junit4] 1> 35160 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 18
[junit4:junit4] 1> 35165 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7987b796 main
[junit4:junit4] 1> 35167 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@7987b796 main{StandardDirectoryReader(segments_i:49:nrt _g(4.4):C11)}
[junit4:junit4] 1> 35168 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35169 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35170 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@7987b796 main{StandardDirectoryReader(segments_i:49:nrt _g(4.4):C11)}
[junit4:junit4] 1> 35430 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35431 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_i,generation=18}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_j,generation=19}
[junit4:junit4] 1> 35433 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 19
[junit4:junit4] 1> 35434 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@4daa8b42 main
[junit4:junit4] 1> 35436 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35438 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=false&maxSegments=1&wt=javabin&version=2} {add=[47 (1437678981583208448)],optimize=,optimize=} 0 303
[junit4:junit4] 1> 35439 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@4daa8b42 main{StandardDirectoryReader(segments_i:49:nrt _g(4.4):C11)}
[junit4:junit4] 1> 35441 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35441 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 47 is 200
[junit4:junit4] 1> 35443 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@30a1718e
[junit4:junit4] 1> 35446 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@4daa8b42 main{StandardDirectoryReader(segments_i:49:nrt _g(4.4):C11)}
[junit4:junit4] 1> 35457 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35476 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_j,generation=19}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_k,generation=20}
[junit4:junit4] 1> 35477 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 20
[junit4:junit4] 1> 35480 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@78a0d37f main
[junit4:junit4] 1> 35482 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@78a0d37f main{StandardDirectoryReader(segments_k:53:nrt _i(4.4):C12)}
[junit4:junit4] 1> 35482 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35482 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35485 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@78a0d37f main{StandardDirectoryReader(segments_k:53:nrt _i(4.4):C12)}
[junit4:junit4] 1> 35486 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {add=[48 (1437678981916655616)],optimize=} 0 32
[junit4:junit4] 1> 35510 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1e2aabf8
[junit4:junit4] 1> 35516 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35535 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_k,generation=20}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_l,generation=21}
[junit4:junit4] 1> 35536 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 21
[junit4:junit4] 1> 35540 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@f5c0729 main
[junit4:junit4] 1> 35541 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@f5c0729 main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35541 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35543 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@f5c0729 main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35545 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35806 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35808 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_l,generation=21}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_m,generation=22}
[junit4:junit4] 1> 35809 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 22
[junit4:junit4] 1> 35809 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@36778590 main
[junit4:junit4] 1> 35811 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35814 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=false&maxSegments=1&wt=javabin&version=2} {add=[49 (1437678981980618752)],optimize=,optimize=} 0 300
[junit4:junit4] 1> 35811 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@36778590 main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35815 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35815 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 49 is 200
[junit4:junit4] 1> 35817 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1e2aabf8
[junit4:junit4] 1> 35819 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@36778590 main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35823 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 35825 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_m,generation=22}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_n,generation=23}
[junit4:junit4] 1> 35826 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 23
[junit4:junit4] 1> 35827 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6c069ec main
[junit4:junit4] 1> 35830 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 35831 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@6c069ec main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35832 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 35843 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@6c069ec main{StandardDirectoryReader(segments_l:57:nrt _k(4.4):C13)}
[junit4:junit4] 1> 35845 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 22
[junit4:junit4] 1> 35852 [TEST-SolrExampleStreamingBinaryTest.testWaitOptions-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testWaitOptions
[junit4:junit4] 1> 35884 [TEST-SolrExampleStreamingBinaryTest.testExampleConfig-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testExampleConfig
[junit4:junit4] 1> 35892 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@2c5f07e8 realtime
[junit4:junit4] 1> 35893 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678982373834752)} 0 3
[junit4:junit4] 1> 35896 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1300271a
[junit4:junit4] 1> 36194 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1112211111 (1437678982385369088)]} 0 293
[junit4:junit4] 1> 36197 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 1112211111 is 200
[junit4:junit4] 1> 36198 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1300271a
[junit4:junit4] 1> 36206 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 36214 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_n,generation=23}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_o,generation=24}
[junit4:junit4] 1> 36215 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 24
[junit4:junit4] 1> 36220 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@70c221d7 main
[junit4:junit4] 1> 36222 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@70c221d7 main{StandardDirectoryReader(segments_o:61:nrt _l(4.4):C1)}
[junit4:junit4] 1> 36223 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 36225 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 36230 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@70c221d7 main{StandardDirectoryReader(segments_o:61:nrt _l(4.4):C1)}
[junit4:junit4] 1> 36231 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 25
[junit4:junit4] 1> 36237 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 36238 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_o,generation=24}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_p,generation=25}
[junit4:junit4] 1> 36239 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 25
[junit4:junit4] 1> 36240 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@b12ce69 main
[junit4:junit4] 1> 36241 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 36241 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@b12ce69 main{StandardDirectoryReader(segments_o:61:nrt _l(4.4):C1)}
[junit4:junit4] 1> 36242 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 36246 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@b12ce69 main{StandardDirectoryReader(segments_o:61:nrt _l(4.4):C1)}
[junit4:junit4] 1> 36246 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {optimize=} 0 10
[junit4:junit4] 1> 36252 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:1112211111&wt=javabin&version=2} hits=1 status=0 QTime=2
[junit4:junit4] 1> 36254 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7fad552c
[junit4:junit4] 1> 36550 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2 (1437678982759710720), 3 (1437678982769147904), 4 (1437678982771245056), 5 (1437678982772293632)]} 0 293
[junit4:junit4] 1> 36556 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 2 is 200
[junit4:junit4] 1> 36557 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7fad552c
[junit4:junit4] 1> 36565 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 36580 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_p,generation=25}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_q,generation=26}
[junit4:junit4] 1> 36581 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 26
[junit4:junit4] 1> 36586 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@62766e80 main
[junit4:junit4] 1> 36588 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@62766e80 main{StandardDirectoryReader(segments_q:63:nrt _l(4.4):C1 _m(4.4):C4)}
[junit4:junit4] 1> 36589 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 36595 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@62766e80 main{StandardDirectoryReader(segments_q:63:nrt _l(4.4):C1 _m(4.4):C4)}
[junit4:junit4] 1> 36601 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 36601 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 36
[junit4:junit4] 1> 36606 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 36614 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_q,generation=26}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_r,generation=27}
[junit4:junit4] 1> 36614 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 27
[junit4:junit4] 1> 36618 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@57a014e1 main
[junit4:junit4] 1> 36619 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@57a014e1 main{StandardDirectoryReader(segments_r:65:nrt _n(4.4):C5)}
[junit4:junit4] 1> 36619 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 36621 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@57a014e1 main{StandardDirectoryReader(segments_r:65:nrt _n(4.4):C5)}
[junit4:junit4] 1> 36622 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 36623 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {optimize=} 0 17
[junit4:junit4] 1> 36631 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&wt=javabin&version=2} hits=5 status=0 QTime=2
[junit4:junit4] 1> 36640 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&wt=javabin&fq=inStock:true&version=2} hits=2 status=0 QTime=1
[junit4:junit4] 1> 36648 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&q=foo&wt=javabin&fq={!field+f%3DinStock}true&fq={!term+f%3Dname}hoss&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 36650 [TEST-SolrExampleStreamingBinaryTest.testExampleConfig-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testExampleConfig
[junit4:junit4] 1> 36676 [TEST-SolrExampleStreamingBinaryTest.testUpdateMultiValuedField-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testUpdateMultiValuedField
[junit4:junit4] 1> 36829 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3d66c39
[junit4:junit4] 1> 37124 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123 (1437678983362641920)]} 0 292
[junit4:junit4] 1> 37126 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 123 is 200
[junit4:junit4] 1> 37128 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3d66c39
[junit4:junit4] 1> 37134 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 37142 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_r,generation=27}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_s,generation=28}
[junit4:junit4] 1> 37142 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 28
[junit4:junit4] 1> 37146 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@27dd2519 main
[junit4:junit4] 1> 37149 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@27dd2519 main{StandardDirectoryReader(segments_s:67:nrt _n(4.4):C5 _o(4.4):C1)}
[junit4:junit4] 1> 37149 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 37151 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 37157 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@27dd2519 main{StandardDirectoryReader(segments_s:67:nrt _n(4.4):C5 _o(4.4):C1)}
[junit4:junit4] 1> 37158 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 25
[junit4:junit4] 1> 37164 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:123&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4:junit4] 1> 37166 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@fefe574
[junit4:junit4] 1> 37465 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123 (1437678983717060608)]} 0 294
[junit4:junit4] 1> 37467 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 123 is 200
[junit4:junit4] 1> 37469 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@fefe574
[junit4:junit4] 1> 37475 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 37483 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_s,generation=28}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_t,generation=29}
[junit4:junit4] 1> 37486 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 29
[junit4:junit4] 1> 37487 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@218fcdce main
[junit4:junit4] 1> 37488 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@218fcdce main{StandardDirectoryReader(segments_t:71:nrt _n(4.4):C5 _p(4.4):C1)}
[junit4:junit4] 1> 37488 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 37489 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 37492 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@218fcdce main{StandardDirectoryReader(segments_t:71:nrt _n(4.4):C5 _p(4.4):C1)}
[junit4:junit4] 1> 37492 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 17
[junit4:junit4] 1> 37499 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:123&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 37500 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@70181c87
[junit4:junit4] 1> 37798 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[123 (1437678984070430720)]} 0 294
[junit4:junit4] 1> 37802 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 123 is 200
[junit4:junit4] 1> 37803 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@70181c87
[junit4:junit4] 1> 37812 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 37820 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_t,generation=29}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_u,generation=30}
[junit4:junit4] 1> 37823 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 30
[junit4:junit4] 1> 37838 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@269fe5c5 main
[junit4:junit4] 1> 37843 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 37843 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@269fe5c5 main{StandardDirectoryReader(segments_u:75:nrt _n(4.4):C5 _q(4.4):C1)}
[junit4:junit4] 1> 37843 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 37846 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@269fe5c5 main{StandardDirectoryReader(segments_u:75:nrt _n(4.4):C5 _q(4.4):C1)}
[junit4:junit4] 1> 37847 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 35
[junit4:junit4] 1> 37861 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:123&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 37862 [TEST-SolrExampleStreamingBinaryTest.testUpdateMultiValuedField-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testUpdateMultiValuedField
[junit4:junit4] 1> 37881 [TEST-SolrExampleStreamingBinaryTest.testPivotFacetsMissing-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testPivotFacetsMissing
[junit4:junit4] 1> 37887 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@23ab8f3f realtime
[junit4:junit4] 1> 37888 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678984465743872)} 0 4
[junit4:junit4] 1> 37893 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 37893 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_u,generation=30}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_v,generation=31}
[junit4:junit4] 1> 37894 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 31
[junit4:junit4] 1> 37895 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@2c3a53b main
[junit4:junit4] 1> 37896 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@2c3a53b main{StandardDirectoryReader(segments_u:77:nrt)}
[junit4:junit4] 1> 37896 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 37899 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 37900 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@2c3a53b main{StandardDirectoryReader(segments_u:77:nrt)}
[junit4:junit4] 1> 37901 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 9
[junit4:junit4] 1> 37905 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 37907 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4f6bc6e5
[junit4:junit4] 1> 38203 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1437678984491958272), 2 (1437678984494055424), 3 (1437678984494055425), 4 (1437678984495104000), 5 (1437678984495104001), 6 (1437678984497201152), 7 (1437678984498249728), 8 (1437678984499298304), 9 (1437678984499298305), 10 (1437678984501395456), ... (12 adds)]} 0 293
[junit4:junit4] 1> 38205 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 1 is 200
[junit4:junit4] 1> 38205 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4f6bc6e5
[junit4:junit4] 1> 38211 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 38216 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_v,generation=31}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_w,generation=32}
[junit4:junit4] 1> 38217 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 32
[junit4:junit4] 1> 38219 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@58c77e26 main
[junit4:junit4] 1> 38225 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@58c77e26 main{StandardDirectoryReader(segments_w:79:nrt _r(4.4):C12)}
[junit4:junit4] 1> 38225 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 38226 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 38229 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@58c77e26 main{StandardDirectoryReader(segments_w:79:nrt _r(4.4):C12)}
[junit4:junit4] 1> 38230 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 20
[junit4:junit4] 1> 38237 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? UnInverted multi-valued field {field=features,memSize=4521,tindexSize=43,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 38238 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? UnInverted multi-valued field {field=cat,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 38243 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet.missing=true&facet=true&facet.mincount=0&q=*:*&wt=javabin&facet.pivot=features,cat&facet.pivot=cat,features&facet.pivot=features,cat,inStock&version=2&rows=0} hits=12 status=0 QTime=7
[junit4:junit4] 1> 38251 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&q=*:*&wt=javabin&fq={!tag%3Dmytag}-(features:bbb+AND+cat:a+AND+inStock:true)&facet.pivot={!ex%3Dmytag+key%3Dmykey}features,cat&version=2&rows=0} hits=11 status=0 QTime=2
[junit4:junit4] 1> 38252 [TEST-SolrExampleStreamingBinaryTest.testPivotFacetsMissing-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testPivotFacetsMissing
[junit4:junit4] 1> 38267 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdates-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testSetNullUpdates
[junit4:junit4] 1> 38268 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4fc0b204
[junit4:junit4] 1> 38564 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdates (1437678984872591360)]} 0 292
[junit4:junit4] 1> 38565 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: testSetNullUpdates is 200
[junit4:junit4] 1> 38566 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4fc0b204
[junit4:junit4] 1> 38569 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 38573 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_w,generation=32}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_x,generation=33}
[junit4:junit4] 1> 38573 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 33
[junit4:junit4] 1> 38574 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@1fa80a2d main
[junit4:junit4] 1> 38577 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@1fa80a2d main{StandardDirectoryReader(segments_x:81:nrt _r(4.4):C12 _s(4.4):C1)}
[junit4:junit4] 1> 38578 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 38579 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 38583 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@1fa80a2d main{StandardDirectoryReader(segments_x:81:nrt _r(4.4):C12 _s(4.4):C1)}
[junit4:junit4] 1> 38584 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 16
[junit4:junit4] 1> 38586 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@f43e7b7
[junit4:junit4] 1> 38883 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdates (1437678985204989952)]} 0 293
[junit4:junit4] 1> 38885 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: testSetNullUpdates is 200
[junit4:junit4] 1> 38885 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@f43e7b7
[junit4:junit4] 1> 38891 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 38895 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_x,generation=33}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_y,generation=34}
[junit4:junit4] 1> 38895 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 34
[junit4:junit4] 1> 38899 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@44fd2254 main
[junit4:junit4] 1> 38900 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@44fd2254 main{StandardDirectoryReader(segments_y:85:nrt _r(4.4):C12 _t(4.4):C1)}
[junit4:junit4] 1> 38901 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 38902 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 38905 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@44fd2254 main{StandardDirectoryReader(segments_y:85:nrt _r(4.4):C12 _t(4.4):C1)}
[junit4:junit4] 1> 38906 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 16
[junit4:junit4] 1> 38914 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdates&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 38917 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdates-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testSetNullUpdates
[junit4:junit4] 1> 38936 [TEST-SolrExampleStreamingBinaryTest.testStatistics-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testStatistics
[junit4:junit4] 1> 38968 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7115e166 realtime
[junit4:junit4] 1> 38971 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678985595060224)} 0 9
[junit4:junit4] 1> 38984 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 38986 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_y,generation=34}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_z,generation=35}
[junit4:junit4] 1> 38987 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 35
[junit4:junit4] 1> 38988 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@4123a08e main
[junit4:junit4] 1> 38989 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@4123a08e main{StandardDirectoryReader(segments_y:87:nrt)}
[junit4:junit4] 1> 38989 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 38994 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@4123a08e main{StandardDirectoryReader(segments_y:87:nrt)}
[junit4:junit4] 1> 38998 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 38998 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 14
[junit4:junit4] 1> 39006 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 39009 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1425a311
[junit4:junit4] 1> 39012 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@67aac78d
[junit4:junit4] 1> 39029 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@67aac78d
[junit4:junit4] 1> 39029 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@b97cf78
[junit4:junit4] 1> 39035 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@b97cf78
[junit4:junit4] 1> 39029 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1f7309a
[junit4:junit4] 1> 39036 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1f7309a
[junit4:junit4] 1> 39035 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4521cef5
[junit4:junit4] 1> 39038 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4521cef5
[junit4:junit4] 1> 39031 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@54a01a10
[junit4:junit4] 1> 39040 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@54a01a10
[junit4:junit4] 1> 39324 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc0 (1437678985669509120), doc1 (1437678985675800576), doc2 (1437678985676849152), doc3 (1437678985677897728), doc4 (1437678985679994880), doc5 (1437678985683140608), doc6 (1437678985685237760), doc7 (1437678985685237761), doc8 (1437678985686286336), doc9 (1437678985688383488)]} 0 291
[junit4:junit4] 1> 39327 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc0 is 200
[junit4:junit4] 1> 39327 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1425a311
[junit4:junit4] 1> 39331 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 39335 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_z,generation=35}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_10,generation=36}
[junit4:junit4] 1> 39336 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 36
[junit4:junit4] 1> 39344 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@571cac41 main
[junit4:junit4] 1> 39345 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@571cac41 main{StandardDirectoryReader(segments_10:89:nrt _u(4.4):C10)}
[junit4:junit4] 1> 39346 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 39347 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 39351 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@571cac41 main{StandardDirectoryReader(segments_10:89:nrt _u(4.4):C10)}
[junit4:junit4] 1> 39352 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 22
[junit4:junit4] 1> 39359 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=10 status=0 QTime=2
[junit4:junit4] 1> 39368 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=javabin&version=2&rows=0} hits=10 status=0 QTime=3
[junit4:junit4] 1> 39374 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@4f1b8540 realtime
[junit4:junit4] 1> 39377 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678986026024960)} 0 5
[junit4:junit4] 1> 39381 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 39382 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_10,generation=36}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_11,generation=37}
[junit4:junit4] 1> 39382 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 37
[junit4:junit4] 1> 39384 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@1f4b3950 main
[junit4:junit4] 1> 39386 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@1f4b3950 main{StandardDirectoryReader(segments_10:91:nrt)}
[junit4:junit4] 1> 39386 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 39387 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 39389 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@1f4b3950 main{StandardDirectoryReader(segments_10:91:nrt)}
[junit4:junit4] 1> 39392 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 12
[junit4:junit4] 1> 39397 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 39398 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@204d080d
[junit4:junit4] 1> 39398 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@214b9e0c
[junit4:junit4] 1> 39401 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5c67aece
[junit4:junit4] 1> 39400 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b7536e7
[junit4:junit4] 1> 39405 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b7536e7
[junit4:junit4] 1> 39404 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@791d9ad
[junit4:junit4] 1> 39412 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@791d9ad
[junit4:junit4] 1> 39700 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc10 (1437678986062725120), doc13 (1437678986066919424), doc14 (1437678986067968000)]} 0 290
[junit4:junit4] 1> 39701 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc10 is 200
[junit4:junit4] 1> 39702 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@204d080d
[junit4:junit4] 1> 39702 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc11 (1437678986064822272)]} 0 293
[junit4:junit4] 1> 39704 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc11 is 200
[junit4:junit4] 1> 39704 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@214b9e0c
[junit4:junit4] 1> 39714 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc12 (1437678986077405184)]} 0 292
[junit4:junit4] 1> 39717 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc12 is 200
[junit4:junit4] 1> 39717 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5c67aece
[junit4:junit4] 1> 39724 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 39728 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_11,generation=37}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_12,generation=38}
[junit4:junit4] 1> 39728 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 38
[junit4:junit4] 1> 39730 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6684b1e0 main
[junit4:junit4] 1> 39731 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@6684b1e0 main{StandardDirectoryReader(segments_12:93:nrt _v(4.4):C5)}
[junit4:junit4] 1> 39731 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 39733 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 39736 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@6684b1e0 main{StandardDirectoryReader(segments_12:93:nrt _v(4.4):C5)}
[junit4:junit4] 1> 39737 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 13
[junit4:junit4] 1> 39743 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=5 status=0 QTime=1
[junit4:junit4] 1> 39751 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=javabin&version=2&rows=0} hits=5 status=0 QTime=1
[junit4:junit4] 1> 39760 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@58d300ed realtime
[junit4:junit4] 1> 39761 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678986428678144)} 0 4
[junit4:junit4] 1> 39767 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 39768 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_12,generation=38}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_13,generation=39}
[junit4:junit4] 1> 39768 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 39
[junit4:junit4] 1> 39769 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@78f7821d main
[junit4:junit4] 1> 39771 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@78f7821d main{StandardDirectoryReader(segments_12:95:nrt)}
[junit4:junit4] 1> 39773 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 39773 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 39775 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@78f7821d main{StandardDirectoryReader(segments_12:95:nrt)}
[junit4:junit4] 1> 39776 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4:junit4] 1> 39783 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 39785 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1954f77b
[junit4:junit4] 1> 39786 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2b5d7e8e
[junit4:junit4] 1> 39785 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2d35dd72
[junit4:junit4] 1> 39785 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1943b93b
[junit4:junit4] 1> 39786 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@71fb2e0
[junit4:junit4] 1> 40084 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc1 (1437678986465378304), doc5 (1437678986468524032)]} 0 292
[junit4:junit4] 1> 40085 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc0 (1437678986466426880), doc6 (1437678986475864064), doc7 (1437678986476912640), doc8 (1437678986476912641), doc9 (1437678986482155520)]} 0 292
[junit4:junit4] 1> 40086 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc1 is 200
[junit4:junit4] 1> 40087 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc0 is 200
[junit4:junit4] 1> 40087 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1954f77b
[junit4:junit4] 1> 40089 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2b5d7e8e
[junit4:junit4] 1> 40084 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc2 (1437678986467475456)]} 0 290
[junit4:junit4] 1> 40093 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc2 is 200
[junit4:junit4] 1> 40093 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2d35dd72
[junit4:junit4] 1> 40099 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc3 (1437678986481106944)]} 0 293
[junit4:junit4] 1> 40102 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc3 is 200
[junit4:junit4] 1> 40102 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1943b93b
[junit4:junit4] 1> 40111 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[doc4 (1437678986493689856)]} 0 292
[junit4:junit4] 1> 40114 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: doc4 is 200
[junit4:junit4] 1> 40114 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@71fb2e0
[junit4:junit4] 1> 40120 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 40135 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_13,generation=39}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_14,generation=40}
[junit4:junit4] 1> 40136 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 40
[junit4:junit4] 1> 40141 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7c5acf13 main
[junit4:junit4] 1> 40142 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@7c5acf13 main{StandardDirectoryReader(segments_14:99:nrt _w(4.4):C9 _x(4.4):C1)}
[junit4:junit4] 1> 40143 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 40147 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@7c5acf13 main{StandardDirectoryReader(segments_14:99:nrt _w(4.4):C9 _x(4.4):C1)}
[junit4:junit4] 1> 40151 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 40151 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 31
[junit4:junit4] 1> 40161 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=inStock:true&wt=javabin&version=2} hits=5 status=0 QTime=1
[junit4:junit4] 1> 40172 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=inStock:false&wt=javabin&version=2} hits=5 status=0 QTime=1
[junit4:junit4] 1> 40180 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={f.val_pi.stats.facet=inStock&stats.field=val_pi&stats=true&q=*:*&wt=javabin&version=2&rows=0} hits=10 status=0 QTime=1
[junit4:junit4] 1> 40182 [TEST-SolrExampleStreamingBinaryTest.testStatistics-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testStatistics
[junit4:junit4] 1> 40196 [TEST-SolrExampleStreamingBinaryTest.testUpdateField-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testUpdateField
[junit4:junit4] 1> 40207 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@58a0ee03 realtime
[junit4:junit4] 1> 40208 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678986896343040)} 0 5
[junit4:junit4] 1> 40216 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 40217 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_14,generation=40}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_15,generation=41}
[junit4:junit4] 1> 40217 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 41
[junit4:junit4] 1> 40219 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@34547854 main
[junit4:junit4] 1> 40221 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@34547854 main{StandardDirectoryReader(segments_14:101:nrt)}
[junit4:junit4] 1> 40222 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 40223 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 40225 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@34547854 main{StandardDirectoryReader(segments_14:101:nrt)}
[junit4:junit4] 1> 40228 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 12
[junit4:junit4] 1> 40230 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@477b1683
[junit4:junit4] 1> 40528 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[unique (1437678986930946048)]} 0 292
[junit4:junit4] 1> 40530 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: unique is 200
[junit4:junit4] 1> 40531 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@477b1683
[junit4:junit4] 1> 40537 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 40539 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_15,generation=41}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_16,generation=42}
[junit4:junit4] 1> 40541 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 42
[junit4:junit4] 1> 40542 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@247aa859 main
[junit4:junit4] 1> 40545 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@247aa859 main{StandardDirectoryReader(segments_16:103:nrt _y(4.4):C1)}
[junit4:junit4] 1> 40546 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 40547 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 40548 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@247aa859 main{StandardDirectoryReader(segments_16:103:nrt _y(4.4):C1)}
[junit4:junit4] 1> 40549 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 12
[junit4:junit4] 1> 40557 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 40560 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@251970e2
[junit4:junit4] 1> 40564 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {} 0 0
[junit4:junit4] 1> 40857 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: unique is 409
[junit4:junit4] 1> 40858 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@251970e2
[junit4:junit4] 1> 40862 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 40864 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_16,generation=42}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_17,generation=43}
[junit4:junit4] 1> 40865 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 43
[junit4:junit4] 1> 40865 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@b6c31dc main
[junit4:junit4] 1> 40866 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 40866 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@b6c31dc main{StandardDirectoryReader(segments_16:103:nrt _y(4.4):C1)}
[junit4:junit4] 1> 40866 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 40870 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@b6c31dc main{StandardDirectoryReader(segments_16:103:nrt _y(4.4):C1)}
[junit4:junit4] 1> 40871 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 9
[junit4:junit4] 1> 40872 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@338f6c7d
[junit4:junit4] 1> 41192 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[unique (1437678987604131840)]} 0 315
[junit4:junit4] 1> 41195 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: unique is 200
[junit4:junit4] 1> 41195 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@338f6c7d
[junit4:junit4] 1> 41200 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 41205 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_17,generation=43}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_18,generation=44}
[junit4:junit4] 1> 41205 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? newest commit generation = 44
[junit4:junit4] 1> 41207 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@7c721098 main
[junit4:junit4] 1> 41208 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@7c721098 main{StandardDirectoryReader(segments_18:107:nrt _z(4.4):C1)}
[junit4:junit4] 1> 41208 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 41210 [qtp1621292085-81] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 41216 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@7c721098 main{StandardDirectoryReader(segments_18:107:nrt _z(4.4):C1)}
[junit4:junit4] 1> 41217 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 19
[junit4:junit4] 1> 41222 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4:junit4] 1> 41225 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@38351fbf
[junit4:junit4] 1> 41548 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[unique (1437678987971133440)]} 0 320
[junit4:junit4] 1> 41551 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: unique is 200
[junit4:junit4] 1> 41552 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@38351fbf
[junit4:junit4] 1> 41560 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 41565 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_18,generation=44}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_19,generation=45}
[junit4:junit4] 1> 41566 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? newest commit generation = 45
[junit4:junit4] 1> 41570 [qtp1621292085-80] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@2e26c3a1 main
[junit4:junit4] 1> 41571 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@2e26c3a1 main{StandardDirectoryReader(segments_19:111:nrt _10(4.4):C1)}
[junit4:junit4] 1> 41572 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 41573 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 41576 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@2e26c3a1 main{StandardDirectoryReader(segments_19:111:nrt _10(4.4):C1)}
[junit4:junit4] 1> 41580 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 20
[junit4:junit4] 1> 41586 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 41587 [TEST-SolrExampleStreamingBinaryTest.testUpdateField-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testUpdateField
[junit4:junit4] 1> 41609 [TEST-SolrExampleStreamingBinaryTest.testRealtimeGet-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testRealtimeGet
[junit4:junit4] 1> 41619 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6144f47b realtime
[junit4:junit4] 1> 41619 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678988375883776)} 0 5
[junit4:junit4] 1> 41621 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@760ee920
[junit4:junit4] 1> 41950 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[DOCID (1437678988388466688)]} 0 324
[junit4:junit4] 1> 41951 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: DOCID is 200
[junit4:junit4] 1> 41952 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@760ee920
[junit4:junit4] 1> 41957 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 41961 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_19,generation=45}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1a,generation=46}
[junit4:junit4] 1> 41964 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 46
[junit4:junit4] 1> 41964 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@3dd688e7 main
[junit4:junit4] 1> 41966 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 41967 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@3dd688e7 main{StandardDirectoryReader(segments_1a:115:nrt _11(4.4):C1)}
[junit4:junit4] 1> 41967 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 41971 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@3dd688e7 main{StandardDirectoryReader(segments_1a:115:nrt _11(4.4):C1)}
[junit4:junit4] 1> 41975 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 18
[junit4:junit4] 1> 41981 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/get params={id=DOCID&fl=id,name,aaa:[value+v%3Daaa]&wt=javabin&qt=/get&version=2} status=0 QTime=1
[junit4:junit4] 1> 41989 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/get params={id=DOCID&fl=id,name,aaa:[value+v%3Daaa]&wt=xml&qt=/get&version=2.2} status=0 QTime=2
[junit4:junit4] 1> 42074 [TEST-SolrExampleStreamingBinaryTest.testRealtimeGet-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testRealtimeGet
[junit4:junit4] 1> 42092 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testUpdateRequestWithParameters
[junit4:junit4] 1> 42092 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil ? Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 1> 42132 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@569d4a90 realtime
[junit4:junit4] 1> 42133 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678988915900416)} 0 4
[junit4:junit4] 1> 42138 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 42140 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1a,generation=46}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1b,generation=47}
[junit4:junit4] 1> 42140 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? newest commit generation = 47
[junit4:junit4] 1> 42140 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@2eb7ec3a main
[junit4:junit4] 1> 42142 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@2eb7ec3a main{StandardDirectoryReader(segments_1a:117:nrt)}
[junit4:junit4] 1> 42142 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 42143 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 42147 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@2eb7ec3a main{StandardDirectoryReader(segments_1a:117:nrt)}
[junit4:junit4] 1> 42148 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4:junit4] 1> 42151 [concurrentUpdateScheduler-3-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@554bce4f
[junit4:junit4] 1> 42152 [concurrentUpdateScheduler-3-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@a5c0f8f
[junit4:junit4] 1> 42153 [concurrentUpdateScheduler-3-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@dc30dfa
[junit4:junit4] 1> 42153 [concurrentUpdateScheduler-3-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@9293709
[junit4:junit4] 1> 42156 [concurrentUpdateScheduler-3-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@9293709
[junit4:junit4] 1> 42157 [concurrentUpdateScheduler-3-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@dc30dfa
[junit4:junit4] 1> 42486 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={overwrite=false&wt=javabin&version=2} {add=[id1 (1437678988954697728)]} 0 320
[junit4:junit4] 1> 42487 [concurrentUpdateScheduler-3-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: id1 is 200
[junit4:junit4] 1> 42487 [concurrentUpdateScheduler-3-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@554bce4f
[junit4:junit4] 1> 42492 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={overwrite=false&wt=javabin&version=2} {add=[id1 (1437678988960989184)]} 0 321
[junit4:junit4] 1> 42496 [concurrentUpdateScheduler-3-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: id1 is 200
[junit4:junit4] 1> 42496 [concurrentUpdateScheduler-3-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@a5c0f8f
[junit4:junit4] 1> 42507 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 42509 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1b,generation=47}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1c,generation=48}
[junit4:junit4] 1> 42511 [qtp1621292085-77] INFO org.apache.solr.core.SolrCore ? newest commit generation = 48
[junit4:junit4] 1> 42512 [qtp1621292085-77] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6929ae9b main
[junit4:junit4] 1> 42514 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@6929ae9b main{StandardDirectoryReader(segments_1c:119:nrt _12(4.4):C2)}
[junit4:junit4] 1> 42514 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 42514 [qtp1621292085-77] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 42519 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@6929ae9b main{StandardDirectoryReader(segments_1c:119:nrt _12(4.4):C2)}
[junit4:junit4] 1> 42521 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 14
[junit4:junit4] 1> 42527 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=1
[junit4:junit4] 1> 42529 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testUpdateRequestWithParameters
[junit4:junit4] 1> 42546 [TEST-SolrExampleStreamingBinaryTest.testQueryWithParams-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testQueryWithParams
[junit4:junit4] 1> 42552 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=query&debug=true&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 42557 [TEST-SolrExampleStreamingBinaryTest.testQueryWithParams-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testQueryWithParams
[junit4:junit4] 1> 42568 [TEST-SolrExampleStreamingBinaryTest.testPivotFacets-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testPivotFacets
[junit4:junit4] 1> 42573 [qtp1621292085-81] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@3cfe8153 realtime
[junit4:junit4] 1> 42575 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678989380419584)} 0 3
[junit4:junit4] 1> 42580 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 42580 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1c,generation=48}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1d,generation=49}
[junit4:junit4] 1> 42581 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 49
[junit4:junit4] 1> 42582 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@4979b3e6 main
[junit4:junit4] 1> 42583 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@4979b3e6 main{StandardDirectoryReader(segments_1c:121:nrt)}
[junit4:junit4] 1> 42583 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 42585 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 42586 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@4979b3e6 main{StandardDirectoryReader(segments_1c:121:nrt)}
[junit4:junit4] 1> 42587 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 9
[junit4:junit4] 1> 42592 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 42593 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1df6bc1a
[junit4:junit4] 1> 42921 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1 (1437678989407682560), 2 (1437678989410828288), 3 (1437678989410828289), 4 (1437678989411876864), 5 (1437678989412925440), 6 (1437678989412925441), 7 (1437678989415022592), 8 (1437678989415022593), 9 (1437678989416071168), 10 (1437678989416071169), ... (12 adds)]} 0 323
[junit4:junit4] 1> 42923 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: 1 is 200
[junit4:junit4] 1> 42923 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1df6bc1a
[junit4:junit4] 1> 42930 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 42932 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1d,generation=49}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_1e,generation=50}
[junit4:junit4] 1> 42933 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? newest commit generation = 50
[junit4:junit4] 1> 42936 [qtp1621292085-78] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@1d05c9a1 main
[junit4:junit4] 1> 42938 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@1d05c9a1 main{StandardDirectoryReader(segments_1e:123:nrt _13(4.4):C12)}
[junit4:junit4] 1> 42938 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 42938 [qtp1621292085-78] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 42941 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@1d05c9a1 main{StandardDirectoryReader(segments_1e:123:nrt _13(4.4):C12)}
[junit4:junit4] 1> 42943 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 16
[junit4:junit4] 1> 42951 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? UnInverted multi-valued field {field=features,memSize=4521,tindexSize=43,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 42952 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? UnInverted multi-valued field {field=cat,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 42956 [qtp1621292085-81] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet.missing=false&facet=true&facet.mincount=0&q=*:*&wt=javabin&facet.pivot=features,cat&facet.pivot=cat,features&facet.pivot=features,cat,inStock&version=2&rows=0} hits=12 status=0 QTime=6
[junit4:junit4] 1> 42966 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&q=*:*&wt=javabin&fq={!tag%3Dmytag}-(features:bbb+AND+cat:a+AND+inStock:true)&facet.pivot={!ex%3Dmytag+key%3Dmykey}features,cat&version=2&rows=0} hits=11 status=0 QTime=2
[junit4:junit4] 1> 42969 [TEST-SolrExampleStreamingBinaryTest.testPivotFacets-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testPivotFacets
[junit4:junit4] 1> 42986 [TEST-SolrExampleStreamingBinaryTest.testLukeHandler-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Starting testLukeHandler
[junit4:junit4] 1> 42994 [qtp1621292085-82] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@3383bff8 realtime
[junit4:junit4] 1> 42995 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1437678989818724352)} 0 5
[junit4:junit4] 1> 42996 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@eb04d34
[junit4:junit4] 1> 42996 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@10dd151f
[junit4:junit4] 1> 42997 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@110bc436
[junit4:junit4] 1> 42997 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2295aedf
[junit4:junit4] 1> 42996 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@589c9874
[junit4:junit4] 1> 43322 [qtp1621292085-80] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[ID0 (1437678989830258688)]} 0 322
[junit4:junit4] 1> 43324 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: ID0 is 200
[junit4:junit4] 1> 43324 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@eb04d34
[junit4:junit4] 1> 43325 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[ID2 (1437678989834452992)]} 0 320
[junit4:junit4] 1> 43325 [qtp1621292085-78] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[ID3 (1437678989834452993)]} 0 320
[junit4:junit4] 1> 43326 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: ID2 is 200
[junit4:junit4] 1> 43327 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@110bc436
[junit4:junit4] 1> 43327 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: ID3 is 200
[junit4:junit4] 1> 43327 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2295aedf
[junit4:junit4] 1> 43329 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[ID1 (1437678989839695872)]} 0 319
[junit4:junit4] 1> 43329 [qtp1621292085-81] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[ID4 (1437678989838647296)]} 0 322
[junit4:junit4] 1> 43330 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: ID1 is 200
[junit4:junit4] 1> 43331 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: ID4 is 200
[junit4:junit4] 1> 43331 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@589c9874
[junit4:junit4] 1> 43332 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@10dd151f
[junit4:junit4] 1> 43339 [qtp1621292085-80] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 43342 [qtp1621292085-
[...truncated too long message...]
gments_21:173:nrt _1h(4.4):C2)}
[junit4:junit4] 1> 250669 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 250669 [qtp1621292085-82] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 250672 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@666c211a main{StandardDirectoryReader(segments_21:173:nrt _1h(4.4):C2)}
[junit4:junit4] 1> 250672 [qtp1621292085-82] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 19
[junit4:junit4] 1> 250675 [qtp1621292085-78] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={sort=price+asc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=1
[junit4:junit4] 1> 250676 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@447ffd8e
[junit4:junit4] 1> 250929 [qtp1621292085-77] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id1 (1437679207596425216), id2 (1437679207598522368)]} 0 251
[junit4:junit4] 1> 250930 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? Status for: id1 is 200
[junit4:junit4] 1> 250930 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer ? finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@447ffd8e
[junit4:junit4] 1> 250934 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 250936 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_21,generation=73}
[junit4:junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@41eab16b lockFactory=org.apache.lucene.store.NativeFSLockFactory@346fe350),segFN=segments_22,generation=74}
[junit4:junit4] 1> 250936 [qtp1621292085-79] INFO org.apache.solr.core.SolrCore ? newest commit generation = 74
[junit4:junit4] 1> 250938 [qtp1621292085-79] INFO org.apache.solr.search.SolrIndexSearcher ? Opening Searcher@6a70122 main
[junit4:junit4] 1> 250939 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener sending requests to Searcher@6a70122 main{StandardDirectoryReader(segments_22:177:nrt _1i(4.4):C2)}
[junit4:junit4] 1> 250939 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? QuerySenderListener done.
[junit4:junit4] 1> 250940 [qtp1621292085-79] INFO org.apache.solr.update.UpdateHandler ? end_commit_flush
[junit4:junit4] 1> 250942 [searcherExecutor-60-thread-1] INFO org.apache.solr.core.SolrCore ? [collection1] Registered new searcher Searcher@6a70122 main{StandardDirectoryReader(segments_22:177:nrt _1i(4.4):C2)}
[junit4:junit4] 1> 250943 [qtp1621292085-79] INFO org.apache.solr.update.processor.LogUpdateProcessor ? [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4:junit4] 1> 250947 [qtp1621292085-80] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={sort=price+asc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=1
[junit4:junit4] 1> 250952 [qtp1621292085-82] INFO org.apache.solr.core.SolrCore ? [collection1] webapp=/solr path=/select params={sort=price+asc&q=name:h?llo&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 250954 [TEST-SolrExampleStreamingBinaryTest.testAddRetrieve-seed#[66671C7DCD44BD4C]] INFO org.apache.solr.SolrTestCaseJ4 ? ###Ending testAddRetrieve
[junit4:junit4] 1> 250967 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CoreContainer ? Shutting down CoreContainer instance=1597843551
[junit4:junit4] 1> 250968 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCore ? [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5886f847
[junit4:junit4] 1> 250990 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.update.UpdateHandler ? closing DirectUpdateHandler2{commits=68,autocommit maxTime=15000ms,autocommits=1,soft autocommits=3,optimizes=8,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=147,cumulative_deletesById=5,cumulative_deletesByQuery=28,cumulative_errors=1}
[junit4:junit4] 1> 250992 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.update.SolrCoreState ? Closing SolrCoreState
[junit4:junit4] 1> 250992 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.update.DefaultSolrCoreState ? SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 1> 250992 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.update.DefaultSolrCoreState ? closing IndexWriter with IndexWriterCloser
[junit4:junit4] 1> 251048 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.SolrCore ? [collection1] Closing main searcher on request.
[junit4:junit4] 1> 251049 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CachingDirectoryFactory ? Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4:junit4] 1> 251049 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CachingDirectoryFactory ? looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\;done=false>>]
[junit4:junit4] 1> 251050 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CachingDirectoryFactory ? Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\
[junit4:junit4] 1> 251050 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CachingDirectoryFactory ? looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index;done=false>>]
[junit4:junit4] 1> 251051 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.core.CachingDirectoryFactory ? Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1371077512014\index
[junit4:junit4] 1> 251051 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.eclipse.jetty.server.handler.ContextHandler ? stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4] 1> 251106 [SUITE-SolrExampleStreamingBinaryTest-seed#[66671C7DCD44BD4C]-worker] INFO org.apache.solr.SolrTestCaseJ4 ? ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=DefaultSimilarity, locale=et_EE, timezone=Libya
[junit4:junit4] 2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_45 (64-bit)/cpus=2,threads=6,free=10417672,total=38772736
[junit4:junit4] 2> NOTE: All tests run in this JVM: [FieldAnalysisResponseTest, ClientUtilsTest, SolrDocumentTest, LargeVolumeJettyTest, IteratorChainTest, SolrExampleEmbeddedTest, TestFastInputStream, SolrPingTest, TestXMLEscaping, TestSolrProperties, SolrExampleStreamingBinaryTest]
[junit4:junit4] Completed in 223.99s, 27 tests, 1 error <<< FAILURES!
[...truncated 116 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:391: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:371: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:194: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:437: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1243: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:887: There were test failures: 46 suites, 272 tests, 1 error, 1 ignored (1 assumption)
Total time: 77 minutes 52 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.6.0_45 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure