lucene-dev mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From Policeman Jenkins Server <jenk...@thetaphi.de>
Subject [JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.7.0_21) - Build # 2771 - Failure!
Date Sun, 28 Apr 2013 10:26:11 GMT
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/2771/
Java: 64bit/jdk1.7.0_21 -XX:+UseCompressedOops -XX:+UseG1GC

1 tests failed.
REGRESSION:  org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest.testGetEmptyResults

Error Message:
IOException occured when talking to server at: https://127.0.0.1:64794/solr/collection1

Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:64794/solr/collection1
	at __randomizedtesting.SeedInfo.seed([684260099B060508:33837117AF816102]: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:57)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:601)
	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:722)
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 10143 lines...]
[junit4:junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest
[junit4:junit4]   1> 11043 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] WARN  org.apache.solr.SolrTestCaseJ4  � startTrackingSearchers: numOpens=1 numCloses=1
[junit4:junit4]   1> 11100 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.SolrJettyTestBase  � Randomized ssl (true) and clientAuth (false)
[junit4:junit4]   1> 11101 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.SolrTestCaseJ4  � ####initCore
[junit4:junit4]   1> 11104 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.SolrTestCaseJ4  � ####initCore end
[junit4:junit4]   1> 11172 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.eclipse.jetty.server.Server  � jetty-8.1.10.v20130312
[junit4:junit4]   1> 11410 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.eclipse.jetty.util.ssl.SslContextFactory  � Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4:junit4]   1> 11435 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.eclipse.jetty.server.AbstractConnector  � Started SslSelectChannelConnector@127.0.0.1:64794
[junit4:junit4]   1> 11440 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  � SolrDispatchFilter.init()
[junit4:junit4]   1> 11450 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrResourceLoader  � JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4]   1> 11451 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrResourceLoader  � using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr
[junit4:junit4]   1> 11451 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CoreContainer  � looking for solr config file: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\solr.xml
[junit4:junit4]   1> 11452 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CoreContainer  � New CoreContainer 1751618666
[junit4:junit4]   1> 11453 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CoreContainer  � Loading CoreContainer using Solr Home: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\'
[junit4:junit4]   1> 11454 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrResourceLoader  � new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\'
[junit4:junit4]   1> 11642 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr
[junit4:junit4]   1> 11644 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn
[junit4:junit4]   1> 11646 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\prop-base
[junit4:junit4]   1> 11649 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\props
[junit4:junit4]   1> 11651 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\text-base
[junit4:junit4]   1> 11654 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\tmp
[junit4:junit4]   1> 11656 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\tmp\prop-base
[junit4:junit4]   1> 11657 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\tmp\props
[junit4:junit4]   1> 11659 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Looking for cores in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\.svn\tmp\text-base
[junit4:junit4]   1> 11660 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCoreDiscoverer  � Discovered properties file C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\core.properties, adding to cores
[junit4:junit4]   1> SET INST DIR:C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1
[junit4:junit4]   1> 11674 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting socketTimeout to: 0
[junit4:junit4]   1> 11674 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting urlScheme to: http://
[junit4:junit4]   1> 11675 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting connTimeout to: 0
[junit4:junit4]   1> 11675 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting maxConnectionsPerHost to: 20
[junit4:junit4]   1> 11675 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting corePoolSize to: 0
[junit4:junit4]   1> 11676 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting maximumPoolSize to: 2147483647
[junit4:junit4]   1> 11677 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting maxThreadIdleTime to: 5
[junit4:junit4]   1> 11678 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting sizeOfQueue to: -1
[junit4:junit4]   1> 11679 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.handler.component.HttpShardHandlerFactory  � Setting fairnessPolicy to: false
[junit4:junit4]   1> 11679 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-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> 11686 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CoreContainer  � Registering Log Listener
[junit4:junit4]   1> 11691 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.CoreContainer  � Creating SolrCore 'collection1' using instanceDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1
[junit4:junit4]   1> 11693 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrResourceLoader  � new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\'
[junit4:junit4]   1> 11751 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrConfig  � Adding specified lib dirs to ClassLoader
[junit4:junit4]   1> 11753 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\contrib\extraction\lib).
[junit4:junit4]   1> 11754 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4]   1> 11756 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\contrib\clustering\lib).
[junit4:junit4]   1> 11756 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4]   1> 11757 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\contrib\langid\lib).
[junit4:junit4]   1> 11758 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4]   1> 11759 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\contrib\velocity\lib).
[junit4:junit4]   1> 11760 [coreLoadExecutor-10-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-trunk-Windows\solr\example\solr\collection1\..\..\..\dist).
[junit4:junit4]   1> 11761 [coreLoadExecutor-10-thread-1] WARN  org.apache.solr.core.SolrResourceLoader  � Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\non\existent\dir\yields\warning).
[junit4:junit4]   1> 11882 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrConfig  � Using Lucene MatchVersion: LUCENE_50
[junit4:junit4]   1> 12017 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.Config  � Loaded SolrConfig: solrconfig.xml
[junit4:junit4]   1> 12019 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.schema.IndexSchema  � Reading Solr Schema from schema.xml
[junit4:junit4]   1> 12051 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.schema.IndexSchema  � Schema name=example
[junit4:junit4]   1> 12981 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.schema.IndexSchema  � unique key field: id
[junit4:junit4]   1> 13007 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.schema.FileExchangeRateProvider  � Reloading exchange rates from file currency.xml
[junit4:junit4]   1> 13017 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.schema.FileExchangeRateProvider  � Reloading exchange rates from file currency.xml
[junit4:junit4]   1> 13087 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   1> 13088 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\
[junit4:junit4]   1> 13088 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.JmxMonitoredMap  � JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@198a290f
[junit4:junit4]   1> 13097 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4]   1> 13098 [coreLoadExecutor-10-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> 13098 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � org.apache.solr.core.MockDirectoryFactory
[junit4:junit4]   1> 13099 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.CachingDirectoryFactory  � return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\
[junit4:junit4]   1> 13099 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index/
[junit4:junit4]   1> 13100 [coreLoadExecutor-10-thread-1] WARN  org.apache.solr.core.SolrCore  � [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index' doesn't exist. Creating new index...
[junit4:junit4]   1> 13113 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.CachingDirectoryFactory  � return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index
[junit4:junit4]   1> 13117 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1,generation=1}
[junit4:junit4]   1> 13118 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 1
[junit4:junit4]   1> 13120 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � created json: solr.JSONResponseWriter
[junit4:junit4]   1> 13120 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4:junit4]   1> 13120 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � created velocity: solr.VelocityResponseWriter
[junit4:junit4]   1> 13121 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � created xslt: solr.XSLTResponseWriter
[junit4:junit4]   1> 13121 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.response.XSLTResponseWriter  � xsltCacheLifetimeSeconds=5
[junit4:junit4]   1> 13125 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /select: solr.SearchHandler
[junit4:junit4]   1> 13127 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /query: solr.SearchHandler
[junit4:junit4]   1> 13129 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /get: solr.RealTimeGetHandler
[junit4:junit4]   1> 13130 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /browse: solr.SearchHandler
[junit4:junit4]   1> 13130 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /update: solr.UpdateRequestHandler
[junit4:junit4]   1> 13131 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /update/json: solr.JsonUpdateRequestHandler
[junit4:junit4]   1> 13131 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /update/csv: solr.CSVRequestHandler
[junit4:junit4]   1> 13132 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4:junit4]   1> 13133 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4:junit4]   1> 13134 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4:junit4]   1> 13134 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4:junit4]   1> 13135 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4:junit4]   1> 13135 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4:junit4]   1> 13135 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /admin/: solr.admin.AdminHandlers
[junit4:junit4]   1> 13136 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /admin/ping: solr.PingRequestHandler
[junit4:junit4]   1> 13137 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /debug/dump: solr.DumpRequestHandler
[junit4:junit4]   1> 13138 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /replication: solr.ReplicationHandler
[junit4:junit4]   1> 13139 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 13140 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /spell: solr.SearchHandler
[junit4:junit4]   1> 13140 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 13140 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /tvrh: solr.SearchHandler
[junit4:junit4]   1> 13141 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 13141 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /terms: solr.SearchHandler
[junit4:junit4]   1> 13142 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � adding lazy requestHandler: solr.SearchHandler
[junit4:junit4]   1> 13142 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.RequestHandlers  � created /elevate: solr.SearchHandler
[junit4:junit4]   1> 13153 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  � xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 13155 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  � xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 13158 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.loader.XMLLoader  � xsltCacheLifetimeSeconds=60
[junit4:junit4]   1> 13166 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@4229c502 main
[junit4:junit4]   1> 13167 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.update.UpdateHandler  � Clearing tlog files, tlogDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\tlog
[junit4:junit4]   1> 13170 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � Hard AutoCommit: if uncommited for 15000ms; 
[junit4:junit4]   1> 13170 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.SolrCore  � Soft AutoCommit: disabled
[junit4:junit4]   1> 13171 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  � Initializing spell checkers
[junit4:junit4]   1> 13171 [coreLoadExecutor-10-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> 13172 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  � No queryConverter defined, using default converter
[junit4:junit4]   1> 13174 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.component.QueryElevationComponent  � Loading QueryElevation from: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\conf\elevate.xml
[junit4:junit4]   1> 13195 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.handler.ReplicationHandler  � Commits will be reserved for  10000
[junit4:junit4]   1> 13196 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@4229c502 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   1> 13198 [searcherExecutor-11-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> 13198 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 13199 [searcherExecutor-11-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  � Loading spell index for spellchecker: default
[junit4:junit4]   1> 13200 [searcherExecutor-11-thread-1] INFO  org.apache.solr.handler.component.SpellCheckComponent  � Loading spell index for spellchecker: wordbreak
[junit4:junit4]   1> 13201 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@4229c502 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4]   1> 13211 [coreLoadExecutor-10-thread-1] INFO  org.apache.solr.core.CoreContainer  � registering core: collection1
[junit4:junit4]   1> 13211 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  � user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0
[junit4:junit4]   1> 13211 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.servlet.SolrDispatchFilter  � SolrDispatchFilter.init() done
[junit4:junit4]   1> 13212 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.SolrJettyTestBase  � Jetty Assigned Port#64794
[junit4:junit4]   2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\.\solrtest-SolrExampleStreamingTest-1367144357284
[junit4:junit4]   1> 13229 [TEST-SolrExampleStreamingTest.testQueryWithParams-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testQueryWithParams
[junit4:junit4]   1> 13276 [TEST-SolrExampleStreamingTest.testQueryWithParams-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.HttpClientUtil  � Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   1> 14024 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=query&debug=true&wt=xml&version=2.2} hits=0 status=0 QTime=26 
[junit4:junit4]   1> 14302 [TEST-SolrExampleStreamingTest.testQueryWithParams-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testQueryWithParams
[junit4:junit4]   1> 14326 [TEST-SolrExampleStreamingTest.testStatistics-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testStatistics
[junit4:junit4]   1> 14465 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onInit: commits: num=1
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1,generation=1}
[junit4:junit4]   1> 14467 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 1
[junit4:junit4]   1> 14530 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@18a7082a realtime
[junit4:junit4]   1> 14540 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554765064699904)} 0 149
[junit4:junit4]   1> 14561 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 14564 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1,generation=1}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_2,generation=2}
[junit4:junit4]   1> 14565 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 2
[junit4:junit4]   1> 14568 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@790bb6f4 main
[junit4:junit4]   1> 14581 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@790bb6f4 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4]   1> 14584 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 14587 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@790bb6f4 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4]   1> 14583 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 14591 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 30
[junit4:junit4]   1> 14607 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=6 
[junit4:junit4]   1> 14623 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5655be75
[junit4:junit4]   1> 14625 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@168da839
[junit4:junit4]   1> 14624 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@150b2f3
[junit4:junit4]   1> 14626 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3b022cae
[junit4:junit4]   1> 14626 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@72322884
[junit4:junit4]   1> 14881 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc3 (1433554765341523968), doc5 (1433554765540753408), doc6 (1433554765542850560), doc7 (1433554765543899136), doc8 (1433554765544947712), doc9 (1433554765545996288)]} 0 199
[junit4:junit4]   1> 14884 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc3 is 200
[junit4:junit4]   1> 14885 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3b022cae
[junit4:junit4]   1> 14891 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc4 (1433554765358301184)]} 0 190
[junit4:junit4]   1> 14894 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc4 is 200
[junit4:junit4]   1> 14895 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@72322884
[junit4:junit4]   1> 14895 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc2 (1433554765359349760)]} 0 192
[junit4:junit4]   1> 14896 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc2 is 200
[junit4:junit4]   1> 14901 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@150b2f3
[junit4:junit4]   1> 14911 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc1 (1433554765354106880)]} 0 215
[junit4:junit4]   1> 14912 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc1 is 200
[junit4:junit4]   1> 14913 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@168da839
[junit4:junit4]   1> 14914 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc0 (1433554765363544064)]} 0 208
[junit4:junit4]   1> 14916 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc0 is 200
[junit4:junit4]   1> 14916 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5655be75
[junit4:junit4]   1> 14924 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 15309 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_2,generation=2}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_3,generation=3}
[junit4:junit4]   1> 15310 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 3
[junit4:junit4]   1> 15449 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@20586c6 main
[junit4:junit4]   1> 15451 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@20586c6 main{StandardDirectoryReader(segments_3:7:nrt _0(5.0):C2 _1(5.0):C2 _2(5.0):C6)}
[junit4:junit4]   1> 15451 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 15455 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@20586c6 main{StandardDirectoryReader(segments_3:7:nrt _0(5.0):C2 _1(5.0):C2 _2(5.0):C6)}
[junit4:junit4]   1> 15460 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 15460 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 537
[junit4:junit4]   1> 15507 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=10 status=0 QTime=42 
[junit4:junit4]   1> 15675 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=xml&version=2.2&rows=0} hits=10 status=0 QTime=138 
[junit4:junit4]   1> 15799 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@212bd37a realtime
[junit4:junit4]   1> 15801 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554766389051392)} 0 116
[junit4:junit4]   1> 15805 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 15807 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_3,generation=3}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_4,generation=4}
[junit4:junit4]   1> 15807 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 4
[junit4:junit4]   1> 15813 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@2ce16496 main
[junit4:junit4]   1> 15817 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@2ce16496 main{StandardDirectoryReader(segments_3:9:nrt)}
[junit4:junit4]   1> 15818 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 15818 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 15821 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@2ce16496 main{StandardDirectoryReader(segments_3:9:nrt)}
[junit4:junit4]   1> 15824 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 19
[junit4:junit4]   1> 15829 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0 
[junit4:junit4]   1> 15832 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@38dc54d6
[junit4:junit4]   1> 15832 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@39823684
[junit4:junit4]   1> 15832 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4bb488d0
[junit4:junit4]   1> 15832 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@945cac4
[junit4:junit4]   1> 15834 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@945cac4
[junit4:junit4]   1> 15832 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@45030e9d
[junit4:junit4]   1> 15841 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@45030e9d
[junit4:junit4]   1> 16065 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc10 (1433554766545289216), doc13 (1433554766549483520), doc14 (1433554766549483521)]} 0 231
[junit4:junit4]   1> 16067 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc12 (1433554766552629248)]} 0 227
[junit4:junit4]   1> 16067 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc10 is 200
[junit4:junit4]   1> 16068 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc12 is 200
[junit4:junit4]   1> 16069 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@38dc54d6
[junit4:junit4]   1> 16071 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4bb488d0
[junit4:junit4]   1> 16073 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc11 (1433554766554726400)]} 0 230
[junit4:junit4]   1> 16074 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc11 is 200
[junit4:junit4]   1> 16075 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@39823684
[junit4:junit4]   1> 16080 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 16090 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_4,generation=4}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_5,generation=5}
[junit4:junit4]   1> 16091 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 5
[junit4:junit4]   1> 16094 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@ee3aff0 main
[junit4:junit4]   1> 16095 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@ee3aff0 main{StandardDirectoryReader(segments_5:13:nrt _3(5.0):C4 _4(5.0):C1)}
[junit4:junit4]   1> 16095 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 16095 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 16099 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@ee3aff0 main{StandardDirectoryReader(segments_5:13:nrt _3(5.0):C4 _4(5.0):C1)}
[junit4:junit4]   1> 16100 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 21
[junit4:junit4]   1> 16111 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=5 status=0 QTime=1 
[junit4:junit4]   1> 16133 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=xml&version=2.2&rows=0} hits=5 status=0 QTime=0 
[junit4:junit4]   1> 16144 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5e398c3f realtime
[junit4:junit4]   1> 16146 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554766866153472)} 0 6
[junit4:junit4]   1> 16151 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 16153 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_5,generation=5}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_6,generation=6}
[junit4:junit4]   1> 16153 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 6
[junit4:junit4]   1> 16155 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@42bc6c9d main
[junit4:junit4]   1> 16156 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@42bc6c9d main{StandardDirectoryReader(segments_5:15:nrt)}
[junit4:junit4]   1> 16156 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 16156 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 16160 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@42bc6c9d main{StandardDirectoryReader(segments_5:15:nrt)}
[junit4:junit4]   1> 16163 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 12
[junit4:junit4]   1> 16169 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=2 
[junit4:junit4]   1> 16171 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6d2c0060
[junit4:junit4]   1> 16172 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@63ccd69e
[junit4:junit4]   1> 16173 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1d1e5242
[junit4:junit4]   1> 16193 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4c585e91
[junit4:junit4]   1> 16196 [concurrentUpdateScheduler-1-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4c585e91
[junit4:junit4]   1> 16196 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@36e74627
[junit4:junit4]   1> 16198 [concurrentUpdateScheduler-1-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@36e74627
[junit4:junit4]   1> 16410 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc0 (1433554766904950784), doc3 (1433554766925922305), doc4 (1433554766931165184)]} 0 234
[junit4:junit4]   1> 16413 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc0 is 200
[junit4:junit4]   1> 16414 [concurrentUpdateScheduler-1-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6d2c0060
[junit4:junit4]   1> 16431 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc2 (1433554766925922304), doc5 (1433554766930116608), doc6 (1433554766931165185), doc7 (1433554766934310912), doc8 (1433554766936408064), doc9 (1433554766937456640)]} 0 235
[junit4:junit4]   1> 16433 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc2 is 200
[junit4:junit4]   1> 16434 [concurrentUpdateScheduler-1-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1d1e5242
[junit4:junit4]   1> 16436 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc1 (1433554766932213760)]} 0 234
[junit4:junit4]   1> 16438 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: doc1 is 200
[junit4:junit4]   1> 16440 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@63ccd69e
[junit4:junit4]   1> 16443 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 16450 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_6,generation=6}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_7,generation=7}
[junit4:junit4]   1> 16452 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 7
[junit4:junit4]   1> 16452 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@36033d7 main
[junit4:junit4]   1> 16455 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@36033d7 main{StandardDirectoryReader(segments_7:17:nrt _5(5.0):C10)}
[junit4:junit4]   1> 16457 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 16457 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 16462 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@36033d7 main{StandardDirectoryReader(segments_7:17:nrt _5(5.0):C10)}
[junit4:junit4]   1> 16464 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 22
[junit4:junit4]   1> 16481 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=inStock:true&wt=xml&version=2.2} hits=5 status=0 QTime=9 
[junit4:junit4]   1> 16490 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=inStock:false&wt=xml&version=2.2} hits=5 status=0 QTime=1 
[junit4:junit4]   1> 16535 [qtp523206750-34] 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=xml&version=2.2&rows=0} hits=10 status=0 QTime=37 
[junit4:junit4]   1> 16543 [TEST-SolrExampleStreamingTest.testStatistics-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testStatistics
[junit4:junit4]   1> 16589 [TEST-SolrExampleStreamingTest.testCommitWithinOnDelete-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testCommitWithinOnDelete
[junit4:junit4]   1> 16598 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5fb4f419 realtime
[junit4:junit4]   1> 16614 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554767343255552)} 0 19
[junit4:junit4]   1> 16622 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 16623 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_7,generation=7}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_8,generation=8}
[junit4:junit4]   1> 16623 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 8
[junit4:junit4]   1> 16626 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@42821db main
[junit4:junit4]   1> 16628 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@42821db main{StandardDirectoryReader(segments_7:19:nrt)}
[junit4:junit4]   1> 16629 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 16635 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@42821db main{StandardDirectoryReader(segments_7:19:nrt)}
[junit4:junit4]   1> 16637 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 16639 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4]   1> 16647 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1 
[junit4:junit4]   1> 16668 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e9c6165
[junit4:junit4]   1> 16908 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id3 (1433554767423995904)]} 0 236
[junit4:junit4]   1> 16910 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id3 is 200
[junit4:junit4]   1> 16911 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e9c6165
[junit4:junit4]   1> 16915 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 16920 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_8,generation=8}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_9,generation=9}
[junit4:junit4]   1> 16922 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 9
[junit4:junit4]   1> 16924 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@f751b15 main
[junit4:junit4]   1> 16926 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@f751b15 main{StandardDirectoryReader(segments_9:21:nrt _6(5.0):C1)}
[junit4:junit4]   1> 16926 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 16931 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@f751b15 main{StandardDirectoryReader(segments_9:21:nrt _6(5.0):C1)}
[junit4:junit4]   1> 16931 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 16931 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 16
[junit4:junit4]   1> 16937 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 16946 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {delete=[id3 (-1433554767709208576)]} 0 3
[junit4:junit4]   1> 16951 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 17192 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 17433 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 17673 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=0 
[junit4:junit4]   1> 17913 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=0 
[junit4:junit4]   1> 17948 [commitScheduler-14-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> 17950 [commitScheduler-14-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@294d1a3a main
[junit4:junit4]   1> 17951 [commitScheduler-14-thread-1] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 17951 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@294d1a3a main{StandardDirectoryReader(segments_9:23:nrt)}
[junit4:junit4]   1> 17951 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 17955 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@294d1a3a main{StandardDirectoryReader(segments_9:23:nrt)}
[junit4:junit4]   1> 18156 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=0 status=0 QTime=1 
[junit4:junit4]   1> 18159 [TEST-SolrExampleStreamingTest.testCommitWithinOnDelete-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testCommitWithinOnDelete
[junit4:junit4]   1> 18174 [TEST-SolrExampleStreamingTest.testAugmentFields-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testAugmentFields
[junit4:junit4]   1> 18180 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554769002102784)} 0 3
[junit4:junit4]   1> 18182 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7c7c5bdf
[junit4:junit4]   1> 18419 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[111 (1433554769011539968)]} 0 234
[junit4:junit4]   1> 18421 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 111 is 200
[junit4:junit4]   1> 18422 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7c7c5bdf
[junit4:junit4]   1> 18426 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 18431 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_9,generation=9}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_a,generation=10}
[junit4:junit4]   1> 18432 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 10
[junit4:junit4]   1> 18434 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@532988dd main
[junit4:junit4]   1> 18435 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 18435 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@532988dd main{StandardDirectoryReader(segments_a:25:nrt _7(5.0):C1)}
[junit4:junit4]   1> 18436 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 18439 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@532988dd main{StandardDirectoryReader(segments_a:25:nrt _7(5.0):C1)}
[junit4:junit4]   1> 18441 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4]   1> 18448 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5afafba9
[junit4:junit4]   1> 18688 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[222 (1433554769290461184)]} 0 236
[junit4:junit4]   1> 18690 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 222 is 200
[junit4:junit4]   1> 18691 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5afafba9
[junit4:junit4]   1> 18695 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 18701 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_a,generation=10}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_b,generation=11}
[junit4:junit4]   1> 18702 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 11
[junit4:junit4]   1> 18705 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@6e935f95 main
[junit4:junit4]   1> 18706 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@6e935f95 main{StandardDirectoryReader(segments_b:27:nrt _7(5.0):C1 _8(5.0):C1)}
[junit4:junit4]   1> 18707 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 18707 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 18711 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@6e935f95 main{StandardDirectoryReader(segments_b:27:nrt _7(5.0):C1 _8(5.0):C1)}
[junit4:junit4]   1> 18712 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4]   1> 18920 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={sort=price+asc&fl=id,price,[docid],[explain+style%3Dnl],score,aaa:[value+v%3Daaa],ten:[value+v%3D10+t%3Dint]&q=*:*&wt=xml&version=2.2} hits=2 status=0 QTime=200 
[junit4:junit4]   1> 18924 [TEST-SolrExampleStreamingTest.testAugmentFields-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testAugmentFields
[junit4:junit4]   1> 18948 [TEST-SolrExampleStreamingTest.testMultiContentStreamRequest-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testMultiContentStreamRequest
[junit4:junit4]   1> 18955 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@a17b698 realtime
[junit4:junit4]   1> 18957 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554769814749184)} 0 5
[junit4:junit4]   1> 18963 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 18965 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_b,generation=11}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_c,generation=12}
[junit4:junit4]   1> 18965 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 12
[junit4:junit4]   1> 18968 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@6c09e5bc main
[junit4:junit4]   1> 18969 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@6c09e5bc main{StandardDirectoryReader(segments_b:29:nrt)}
[junit4:junit4]   1> 18970 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 18970 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 18973 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@6c09e5bc main{StandardDirectoryReader(segments_b:29:nrt)}
[junit4:junit4]   1> 18977 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4]   1> 18984 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0 
[junit4:junit4]   1> 19248 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 19269 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_c,generation=12}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_d,generation=13}
[junit4:junit4]   1> 19270 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 13
[junit4:junit4]   1> 19274 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@f474205 main
[junit4:junit4]   1> 19276 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@f474205 main{StandardDirectoryReader(segments_d:31:nrt _9(5.0):C5)}
[junit4:junit4]   1> 19277 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 19278 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 19282 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@f474205 main{StandardDirectoryReader(segments_d:31:nrt _9(5.0):C5)}
[junit4:junit4]   1> 19283 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&echoParams=ALL&commit=true&a=?&wt=xml&version=2.2&softCommit=false} {add=[SP2514N (1433554770071650304), 6H500F0 (1433554770092621824), TWINX2048-3200PRO (1433554770097864704), VS1GB400C3 (1433554770116739072), VDBDB1A16 (1433554770121981952)],commit=} 0 93
[junit4:junit4]   1> 19295 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=5 status=0 QTime=1 
[junit4:junit4]   1> 19321 [TEST-SolrExampleStreamingTest.testMultiContentStreamRequest-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testMultiContentStreamRequest
[junit4:junit4]   1> 19342 [TEST-SolrExampleStreamingTest.testUpdateMultiValuedField-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testUpdateMultiValuedField
[junit4:junit4]   1> 19343 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@d82ea1e
[junit4:junit4]   1> 19583 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[123 (1433554770229985280)]} 0 235
[junit4:junit4]   1> 19586 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 123 is 200
[junit4:junit4]   1> 19587 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@d82ea1e
[junit4:junit4]   1> 19590 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 19601 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_d,generation=13}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_e,generation=14}
[junit4:junit4]   1> 19601 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 14
[junit4:junit4]   1> 19602 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@3232017b main
[junit4:junit4]   1> 19605 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@3232017b main{StandardDirectoryReader(segments_e:33:nrt _9(5.0):C5 _a(5.0):C1)}
[junit4:junit4]   1> 19607 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 19607 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 19613 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@3232017b main{StandardDirectoryReader(segments_e:33:nrt _9(5.0):C5 _a(5.0):C1)}
[junit4:junit4]   1> 19615 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 25
[junit4:junit4]   1> 19622 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:123&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 19625 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6a99d2b4
[junit4:junit4]   1> 19864 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[123 (1433554770576015360)]} 0 234
[junit4:junit4]   1> 19867 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 123 is 200
[junit4:junit4]   1> 19868 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6a99d2b4
[junit4:junit4]   1> 19873 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 19878 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_e,generation=14}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_f,generation=15}
[junit4:junit4]   1> 19879 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 15
[junit4:junit4]   1> 19882 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1bd61b65 main
[junit4:junit4]   1> 19883 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1bd61b65 main{StandardDirectoryReader(segments_f:37:nrt _9(5.0):C5 _b(5.0):C1)}
[junit4:junit4]   1> 19884 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 19886 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 19887 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1bd61b65 main{StandardDirectoryReader(segments_f:37:nrt _9(5.0):C5 _b(5.0):C1)}
[junit4:junit4]   1> 19890 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4]   1> 19896 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:123&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 19899 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@61bf1c70
[junit4:junit4]   1> 20138 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[123 (1433554770812993536)]} 0 234
[junit4:junit4]   1> 20141 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 123 is 200
[junit4:junit4]   1> 20142 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@61bf1c70
[junit4:junit4]   1> 20147 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 20150 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_f,generation=15}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_g,generation=16}
[junit4:junit4]   1> 20151 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 16
[junit4:junit4]   1> 20153 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@63629237 main
[junit4:junit4]   1> 20153 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@63629237 main{StandardDirectoryReader(segments_g:41:nrt _9(5.0):C5 _c(5.0):C1)}
[junit4:junit4]   1> 20154 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 20156 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 20159 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@63629237 main{StandardDirectoryReader(segments_g:41:nrt _9(5.0):C5 _c(5.0):C1)}
[junit4:junit4]   1> 20161 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4]   1> 20168 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:123&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 20171 [TEST-SolrExampleStreamingTest.testUpdateMultiValuedField-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testUpdateMultiValuedField
[junit4:junit4]   1> 20190 [TEST-SolrExampleStreamingTest.testUpdateRequestWithParameters-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testUpdateRequestWithParameters
[junit4:junit4]   1> 20191 [TEST-SolrExampleStreamingTest.testUpdateRequestWithParameters-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.HttpClientUtil  � Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   1> 20249 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@b6c4eb0 realtime
[junit4:junit4]   1> 20250 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554771171606528)} 0 5
[junit4:junit4]   1> 20256 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 20258 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_g,generation=16}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_h,generation=17}
[junit4:junit4]   1> 20259 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 17
[junit4:junit4]   1> 20261 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@423fa750 main
[junit4:junit4]   1> 20262 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@423fa750 main{StandardDirectoryReader(segments_g:43:nrt)}
[junit4:junit4]   1> 20263 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 20265 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 20270 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@423fa750 main{StandardDirectoryReader(segments_g:43:nrt)}
[junit4:junit4]   1> 20272 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 16
[junit4:junit4]   1> 20275 [concurrentUpdateScheduler-2-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@8eea465
[junit4:junit4]   1> 20276 [concurrentUpdateScheduler-2-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@53b00227
[junit4:junit4]   1> 20281 [concurrentUpdateScheduler-2-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1597db22
[junit4:junit4]   1> 20278 [concurrentUpdateScheduler-2-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a91efc3
[junit4:junit4]   1> 20292 [concurrentUpdateScheduler-2-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a91efc3
[junit4:junit4]   1> 20278 [concurrentUpdateScheduler-2-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@581d871e
[junit4:junit4]   1> 20284 [concurrentUpdateScheduler-2-thread-4] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1597db22
[junit4:junit4]   1> 20299 [concurrentUpdateScheduler-2-thread-5] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@581d871e
[junit4:junit4]   1> 20587 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={overwrite=false&wt=xml&version=2.2} {add=[id1 (1433554771218792448)]} 0 296
[junit4:junit4]   1> 20590 [concurrentUpdateScheduler-2-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id1 is 200
[junit4:junit4]   1> 20591 [concurrentUpdateScheduler-2-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@8eea465
[junit4:junit4]   1> 20608 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={overwrite=false&wt=xml&version=2.2} {add=[id1 (1433554771236618240)]} 0 300
[junit4:junit4]   1> 20612 [concurrentUpdateScheduler-2-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id1 is 200
[junit4:junit4]   1> 20613 [concurrentUpdateScheduler-2-thread-2] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@53b00227
[junit4:junit4]   1> 20621 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 20625 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_h,generation=17}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_i,generation=18}
[junit4:junit4]   1> 20625 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 18
[junit4:junit4]   1> 20627 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@61755e66 main
[junit4:junit4]   1> 20629 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@61755e66 main{StandardDirectoryReader(segments_i:45:nrt _d(5.0):C2)}
[junit4:junit4]   1> 20629 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 20630 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 20634 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@61755e66 main{StandardDirectoryReader(segments_i:45:nrt _d(5.0):C2)}
[junit4:junit4]   1> 20636 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4]   1> 20643 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=2 status=0 QTime=1 
[junit4:junit4]   1> 20647 [TEST-SolrExampleStreamingTest.testUpdateRequestWithParameters-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testUpdateRequestWithParameters
[junit4:junit4]   1> 20664 [TEST-SolrExampleStreamingTest.testExampleConfig-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testExampleConfig
[junit4:junit4]   1> 20671 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@108f2c81 realtime
[junit4:junit4]   1> 20672 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554771615154176)} 0 4
[junit4:junit4]   1> 20967 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@27b2d1a5
[junit4:junit4]   1> 21209 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[1112211111 (1433554771932872704)]} 0 238
[junit4:junit4]   1> 21211 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 1112211111 is 200
[junit4:junit4]   1> 21212 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@27b2d1a5
[junit4:junit4]   1> 21218 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 21223 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_i,generation=18}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_j,generation=19}
[junit4:junit4]   1> 21223 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 19
[junit4:junit4]   1> 21225 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@99167db main
[junit4:junit4]   1> 21227 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@99167db main{StandardDirectoryReader(segments_j:49:nrt _e(5.0):C1)}
[junit4:junit4]   1> 21229 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 21228 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 21233 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@99167db main{StandardDirectoryReader(segments_j:49:nrt _e(5.0):C1)}
[junit4:junit4]   1> 21234 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 18
[junit4:junit4]   1> 21241 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 21242 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_j,generation=19}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_k,generation=20}
[junit4:junit4]   1> 21243 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 20
[junit4:junit4]   1> 21244 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@3143f2fb main
[junit4:junit4]   1> 21245 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 21246 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@3143f2fb main{StandardDirectoryReader(segments_j:49:nrt _e(5.0):C1)}
[junit4:junit4]   1> 21247 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 21251 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@3143f2fb main{StandardDirectoryReader(segments_j:49:nrt _e(5.0):C1)}
[junit4:junit4]   1> 21253 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=xml&version=2.2} {optimize=} 0 12
[junit4:junit4]   1> 21259 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:1112211111&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 21266 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5f7d0c2f
[junit4:junit4]   1> 21511 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[2 (1433554772253736960), 3 (1433554772258979840), 4 (1433554772261076992), 5 (1433554772264222720)]} 0 234
[junit4:junit4]   1> 21513 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 2 is 200
[junit4:junit4]   1> 21514 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5f7d0c2f
[junit4:junit4]   1> 21517 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 21524 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_k,generation=20}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_l,generation=21}
[junit4:junit4]   1> 21525 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 21
[junit4:junit4]   1> 21528 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1cc99212 main
[junit4:junit4]   1> 21529 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1cc99212 main{StandardDirectoryReader(segments_l:51:nrt _e(5.0):C1 _f(5.0):C4)}
[junit4:junit4]   1> 21532 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 21535 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 21537 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1cc99212 main{StandardDirectoryReader(segments_l:51:nrt _e(5.0):C1 _f(5.0):C4)}
[junit4:junit4]   1> 21540 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 23
[junit4:junit4]   1> 21545 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 21796 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_l,generation=21}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_m,generation=22}
[junit4:junit4]   1> 21800 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 22
[junit4:junit4]   1> 21805 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@6bf9403d main
[junit4:junit4]   1> 21807 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 21809 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@6bf9403d main{StandardDirectoryReader(segments_m:53:nrt _g(5.0):C5)}
[junit4:junit4]   1> 21811 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 21815 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@6bf9403d main{StandardDirectoryReader(segments_m:53:nrt _g(5.0):C5)}
[junit4:junit4]   1> 21816 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=xml&version=2.2} {optimize=} 0 272
[junit4:junit4]   1> 22092 [qtp523206750-35] 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=xml&version=2.2} hits=5 status=0 QTime=262 
[junit4:junit4]   1> 22170 [qtp523206750-34] 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=xml&fq=inStock:true&version=2.2} hits=2 status=0 QTime=52 
[junit4:junit4]   1> 22215 [qtp523206750-33] 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=xml&fq={!field+f%3DinStock}true&fq={!term+f%3Dname}hoss&version=2.2} hits=0 status=0 QTime=35 
[junit4:junit4]   1> 22219 [TEST-SolrExampleStreamingTest.testExampleConfig-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testExampleConfig
[junit4:junit4]   1> 22241 [TEST-SolrExampleStreamingTest.testUpdateField-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testUpdateField
[junit4:junit4]   1> 22247 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@56df7ace realtime
[junit4:junit4]   1> 22249 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554773268758528)} 0 4
[junit4:junit4]   1> 22258 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 22258 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_m,generation=22}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_n,generation=23}
[junit4:junit4]   1> 22259 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 23
[junit4:junit4]   1> 22260 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@61e9f1b6 main
[junit4:junit4]   1> 22262 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@61e9f1b6 main{StandardDirectoryReader(segments_m:55:nrt)}
[junit4:junit4]   1> 22263 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 22263 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 22267 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@61e9f1b6 main{StandardDirectoryReader(segments_m:55:nrt)}
[junit4:junit4]   1> 22269 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 11
[junit4:junit4]   1> 22270 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@564caf80
[junit4:junit4]   1> 22509 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1433554773297070080)]} 0 235
[junit4:junit4]   1> 22510 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: unique is 200
[junit4:junit4]   1> 22512 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@564caf80
[junit4:junit4]   1> 22517 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 22521 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_n,generation=23}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_o,generation=24}
[junit4:junit4]   1> 22521 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 24
[junit4:junit4]   1> 22522 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@6d691769 main
[junit4:junit4]   1> 22525 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@6d691769 main{StandardDirectoryReader(segments_o:57:nrt _h(5.0):C1)}
[junit4:junit4]   1> 22527 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 22527 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 22532 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@6d691769 main{StandardDirectoryReader(segments_o:57:nrt _h(5.0):C1)}
[junit4:junit4]   1> 22533 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4]   1> 22544 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 22553 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@bdaabe5
[junit4:junit4]   1> 22559 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 3
[junit4:junit4]   1> 22792 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: unique is 409
[junit4:junit4]   1> 22794 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@bdaabe5
[junit4:junit4]   1> 22797 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 22799 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_o,generation=24}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_p,generation=25}
[junit4:junit4]   1> 22800 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 25
[junit4:junit4]   1> 22800 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@183dc442 main
[junit4:junit4]   1> 22801 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 22802 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@183dc442 main{StandardDirectoryReader(segments_o:57:nrt _h(5.0):C1)}
[junit4:junit4]   1> 22803 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 22809 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@183dc442 main{StandardDirectoryReader(segments_o:57:nrt _h(5.0):C1)}
[junit4:junit4]   1> 22811 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 14
[junit4:junit4]   1> 23000 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1968265a
[junit4:junit4]   1> 23239 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1433554774065676288)]} 0 235
[junit4:junit4]   1> 23240 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: unique is 200
[junit4:junit4]   1> 23241 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1968265a
[junit4:junit4]   1> 23246 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 23251 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_p,generation=25}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_q,generation=26}
[junit4:junit4]   1> 23253 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 26
[junit4:junit4]   1> 23256 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@25a517e9 main
[junit4:junit4]   1> 23260 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@25a517e9 main{StandardDirectoryReader(segments_q:61:nrt _i(5.0):C1)}
[junit4:junit4]   1> 23262 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 23262 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 23265 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@25a517e9 main{StandardDirectoryReader(segments_q:61:nrt _i(5.0):C1)}
[junit4:junit4]   1> 23267 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 21
[junit4:junit4]   1> 23274 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 23278 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6aa0328b
[junit4:junit4]   1> 23519 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1433554774357180416)]} 0 236
[junit4:junit4]   1> 23521 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: unique is 200
[junit4:junit4]   1> 23522 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6aa0328b
[junit4:junit4]   1> 23528 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 23533 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_q,generation=26}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_r,generation=27}
[junit4:junit4]   1> 23534 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 27
[junit4:junit4]   1> 23536 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@69885416 main
[junit4:junit4]   1> 23538 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@69885416 main{StandardDirectoryReader(segments_r:65:nrt _j(5.0):C1)}
[junit4:junit4]   1> 23539 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 23539 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 23544 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@69885416 main{StandardDirectoryReader(segments_r:65:nrt _j(5.0):C1)}
[junit4:junit4]   1> 23546 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 18
[junit4:junit4]   1> 23553 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=1 
[junit4:junit4]   1> 23557 [TEST-SolrExampleStreamingTest.testUpdateField-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testUpdateField
[junit4:junit4]   1> 23584 [TEST-SolrExampleStreamingTest.testSetNullUpdateOrder-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testSetNullUpdateOrder
[junit4:junit4]   1> 23586 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@62d25438
[junit4:junit4]   1> 23824 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdateOrder (1433554774678044672)]} 0 235
[junit4:junit4]   1> 23826 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: testSetNullUpdateOrder is 200
[junit4:junit4]   1> 23829 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@62d25438
[junit4:junit4]   1> 23833 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 23839 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_r,generation=27}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_s,generation=28}
[junit4:junit4]   1> 23840 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 28
[junit4:junit4]   1> 23841 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@3ddb547d main
[junit4:junit4]   1> 23843 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@3ddb547d main{StandardDirectoryReader(segments_s:67:nrt _j(5.0):C1 _k(5.0):C1)}
[junit4:junit4]   1> 23846 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 23850 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@3ddb547d main{StandardDirectoryReader(segments_s:67:nrt _j(5.0):C1 _k(5.0):C1)}
[junit4:junit4]   1> 23852 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 23853 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 20
[junit4:junit4]   1> 23931 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6bcdc137
[junit4:junit4]   1> 24171 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdateOrder (1433554775046094848)]} 0 235
[junit4:junit4]   1> 24173 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: testSetNullUpdateOrder is 200
[junit4:junit4]   1> 24174 [concurrentUpdateScheduler-1-thread-3] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6bcdc137
[junit4:junit4]   1> 24177 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 24182 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_s,generation=28}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_t,generation=29}
[junit4:junit4]   1> 24182 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 29
[junit4:junit4]   1> 24184 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@d9422a4 main
[junit4:junit4]   1> 24184 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@d9422a4 main{StandardDirectoryReader(segments_t:71:nrt _j(5.0):C1 _l(5.0):C1)}
[junit4:junit4]   1> 24187 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 24188 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 24190 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@d9422a4 main{StandardDirectoryReader(segments_t:71:nrt _j(5.0):C1 _l(5.0):C1)}
[junit4:junit4]   1> 24192 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4]   1> 24198 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdateOrder&wt=xml&version=2.2} hits=1 status=0 QTime=0 
[junit4:junit4]   1> 24201 [TEST-SolrExampleStreamingTest.testSetNullUpdateOrder-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testSetNullUpdateOrder
[junit4:junit4]   1> 24219 [TEST-SolrExampleStreamingTest.testGetEmptyResults-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testGetEmptyResults
[junit4:junit4]   1> 24232 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@729b297f realtime
[junit4:junit4]   1> 24233 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554775349133312)} 0 4
[junit4:junit4]   1> 40063 [commitScheduler-13-thread-1] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 40064 [commitScheduler-13-thread-1] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_t,generation=29}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_u,generation=30}
[junit4:junit4]   1> 40065 [commitScheduler-13-thread-1] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 30
[junit4:junit4]   1> 40070 [commitScheduler-13-thread-1] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 224497 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 224499 [TEST-SolrExampleStreamingTest.testGetEmptyResults-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testGetEmptyResults
[junit4:junit4]   1> 224504 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_u,generation=30}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_v,generation=31}
[junit4:junit4]   1> 224505 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 31
[junit4:junit4]   1> 224506 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5dd9ed0d main
[junit4:junit4]   1> 224509 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 224512 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@5dd9ed0d main{StandardDirectoryReader(segments_t:73:nrt)}
[junit4:junit4]   1> 224514 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 224522 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@5dd9ed0d main{StandardDirectoryReader(segments_t:73:nrt)}
[junit4:junit4]   1> 224524 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 27
[junit4:junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=SolrExampleStreamingTest -Dtests.method=testGetEmptyResults -Dtests.seed=684260099B060508 -Dtests.slow=true -Dtests.locale=no -Dtests.timezone=Asia/Brunei -Dtests.file.encoding=Cp1252
[junit4:junit4] ERROR    200s | SolrExampleStreamingTest.testGetEmptyResults <<<
[junit4:junit4]    > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:64794/solr/collection1
[junit4:junit4]    > 	at __randomizedtesting.SeedInfo.seed([684260099B060508:33837117AF816102]:0)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer.request(ConcurrentUpdateSolrServer.java:256)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.SolrExampleTests.testGetEmptyResults(SolrExampleTests.java:279)
[junit4:junit4]    > 	at java.lang.Thread.run(Thread.java:722)
[junit4:junit4]    > Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
[junit4:junit4]    > 	at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
[junit4:junit4]    > 	at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
[junit4:junit4]    > 	at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
[junit4:junit4]    > 	at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
[junit4:junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
[junit4:junit4]    > 	at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
[junit4:junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
[junit4:junit4]    > 	at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4:junit4]    > 	at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4:junit4]    > 	at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4:junit4]    > 	... 46 more
[junit4:junit4]   1> 224645 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testWaitOptions
[junit4:junit4]   1> 224646 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.HttpClientUtil  � Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4]   1> 224653 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � blocking for commit/optimize
[junit4:junit4]   1> 224745 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 224748 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_v,generation=31}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_w,generation=32}
[junit4:junit4]   1> 224749 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 32
[junit4:junit4]   1> 224751 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@793c0882 main
[junit4:junit4]   1> 224751 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@793c0882 main{StandardDirectoryReader(segments_w:75:nrt _m(5.0):C1)}
[junit4:junit4]   1> 224752 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 224755 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@793c0882 main{StandardDirectoryReader(segments_w:75:nrt _m(5.0):C1)}
[junit4:junit4]   1> 224758 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 224758 [qtp523206750-37] 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 (1433554985602252800)],commit=} 0 15
[junit4:junit4]   1> 224771 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � blocking for commit/optimize
[junit4:junit4]   1> 224772 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1bcc1503
[junit4:junit4]   1> 224784 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 224788 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_w,generation=32}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_x,generation=33}
[junit4:junit4]   1> 224788 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 33
[junit4:junit4]   1> 224790 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@11c3da0a main
[junit4:junit4]   1> 224791 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@11c3da0a main{StandardDirectoryReader(segments_x:77:nrt _m(5.0):C1 _n(5.0):C1)}
[junit4:junit4]   1> 224791 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 224791 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 224794 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@11c3da0a main{StandardDirectoryReader(segments_x:77:nrt _m(5.0):C1 _n(5.0):C1)}
[junit4:junit4]   1> 225139 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225142 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_x,generation=33}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_y,generation=34}
[junit4:junit4]   1> 225144 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 34
[junit4:junit4]   1> 225146 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@73b2d15a main
[junit4:junit4]   1> 225148 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225149 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@73b2d15a main{StandardDirectoryReader(segments_x:77:nrt _m(5.0):C1 _n(5.0):C1)}
[junit4:junit4]   1> 225152 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225150 [qtp523206750-35] 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 (1433554985643147264)],commit=,commit=} 0 369
[junit4:junit4]   1> 225156 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 43 is 200
[junit4:junit4]   1> 225157 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@73b2d15a main{StandardDirectoryReader(segments_x:77:nrt _m(5.0):C1 _n(5.0):C1)}
[junit4:junit4]   1> 225157 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1bcc1503
[junit4:junit4]   1> 225165 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225168 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_y,generation=34}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_z,generation=35}
[junit4:junit4]   1> 225168 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 35
[junit4:junit4]   1> 225169 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@27080173 main
[junit4:junit4]   1> 225171 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@27080173 main{StandardDirectoryReader(segments_z:79:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1)}
[junit4:junit4]   1> 225172 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225172 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225177 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@27080173 main{StandardDirectoryReader(segments_z:79:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1)}
[junit4:junit4]   1> 225179 [qtp523206750-36] 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 (1433554986041606144)],commit=} 0 19
[junit4:junit4]   1> 225180 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a21becc
[junit4:junit4]   1> 225180 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � blocking for commit/optimize
[junit4:junit4]   1> 225193 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225195 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_z,generation=35}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_10,generation=36}
[junit4:junit4]   1> 225196 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 36
[junit4:junit4]   1> 225197 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5e044857 main
[junit4:junit4]   1> 225198 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@5e044857 main{StandardDirectoryReader(segments_10:81:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1 _p(5.0):C1)}
[junit4:junit4]   1> 225203 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225199 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225207 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@5e044857 main{StandardDirectoryReader(segments_10:81:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1 _p(5.0):C1)}
[junit4:junit4]   1> 225471 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225473 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_10,generation=36}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_11,generation=37}
[junit4:junit4]   1> 225475 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 37
[junit4:junit4]   1> 225477 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@74a0b809 main
[junit4:junit4]   1> 225478 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225481 [qtp523206750-34] 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 (1433554986070966272)],commit=,commit=} 0 290
[junit4:junit4]   1> 225483 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 45 is 200
[junit4:junit4]   1> 225487 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a21becc
[junit4:junit4]   1> 225480 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@74a0b809 main{StandardDirectoryReader(segments_10:81:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1 _p(5.0):C1)}
[junit4:junit4]   1> 225491 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225494 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@74a0b809 main{StandardDirectoryReader(segments_10:81:nrt _m(5.0):C1 _n(5.0):C1 _o(5.0):C1 _p(5.0):C1)}
[junit4:junit4]   1> 225495 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225579 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_11,generation=37}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_12,generation=38}
[junit4:junit4]   1> 225580 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 38
[junit4:junit4]   1> 225586 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@434ac89a main
[junit4:junit4]   1> 225590 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@434ac89a main{StandardDirectoryReader(segments_12:85:nrt _r(5.0):C5)}
[junit4:junit4]   1> 225592 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225593 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225607 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@434ac89a main{StandardDirectoryReader(segments_12:85:nrt _r(5.0):C5)}
[junit4:junit4]   1> 225610 [qtp523206750-38] 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 (1433554986388684800)],optimize=} 0 118
[junit4:junit4]   1> 225612 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � blocking for commit/optimize
[junit4:junit4]   1> 225612 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@221a28c7
[junit4:junit4]   1> 225624 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225642 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_12,generation=38}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_13,generation=39}
[junit4:junit4]   1> 225643 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 39
[junit4:junit4]   1> 225644 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@345356ff main
[junit4:junit4]   1> 225649 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@345356ff main{StandardDirectoryReader(segments_13:89:nrt _t(5.0):C6)}
[junit4:junit4]   1> 225650 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225652 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@345356ff main{StandardDirectoryReader(segments_13:89:nrt _t(5.0):C6)}
[junit4:junit4]   1> 225649 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225906 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225908 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_13,generation=39}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_14,generation=40}
[junit4:junit4]   1> 225910 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 40
[junit4:junit4]   1> 225913 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@24320fa1 main
[junit4:junit4]   1> 225915 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225917 [qtp523206750-33] 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 (1433554986521853952)],optimize=,optimize=} 0 297
[junit4:junit4]   1> 225916 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@24320fa1 main{StandardDirectoryReader(segments_13:89:nrt _t(5.0):C6)}
[junit4:junit4]   1> 225921 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225921 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 47 is 200
[junit4:junit4]   1> 225923 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@221a28c7
[junit4:junit4]   1> 225946 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 225950 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@24320fa1 main{StandardDirectoryReader(segments_13:89:nrt _t(5.0):C6)}
[junit4:junit4]   1> 225956 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_14,generation=40}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_15,generation=41}
[junit4:junit4]   1> 225957 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 41
[junit4:junit4]   1> 225959 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5e73a225 main
[junit4:junit4]   1> 225961 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 225961 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@5e73a225 main{StandardDirectoryReader(segments_15:93:nrt _v(5.0):C7)}
[junit4:junit4]   1> 225962 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 225970 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@5e73a225 main{StandardDirectoryReader(segments_15:93:nrt _v(5.0):C7)}
[junit4:junit4]   1> 225971 [qtp523206750-35] 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 (1433554986855301120)],optimize=} 0 34
[junit4:junit4]   1> 226078 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@50c68fd6
[junit4:junit4]   1> 226085 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 226093 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_15,generation=41}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_16,generation=42}
[junit4:junit4]   1> 226094 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 42
[junit4:junit4]   1> 226095 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1ab1f413 main
[junit4:junit4]   1> 226097 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 226099 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1ab1f413 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226100 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 226101 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1ab1f413 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226367 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 226371 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_16,generation=42}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_17,generation=43}
[junit4:junit4]   1> 226373 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 43
[junit4:junit4]   1> 226374 [qtp523206750-34] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@15b36eb5 main
[junit4:junit4]   1> 226376 [qtp523206750-34] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 226377 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@15b36eb5 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226380 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 226378 [qtp523206750-34] 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 (1433554987007344640)],optimize=,optimize=} 0 295
[junit4:junit4]   1> 226385 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@15b36eb5 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226388 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: 49 is 200
[junit4:junit4]   1> 226390 [concurrentUpdateScheduler-3-thread-1] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@50c68fd6
[junit4:junit4]   1> 226397 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 226400 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_17,generation=43}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_18,generation=44}
[junit4:junit4]   1> 226401 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 44
[junit4:junit4]   1> 226403 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@29730920 main
[junit4:junit4]   1> 226405 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 226405 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@29730920 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226408 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 226415 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@29730920 main{StandardDirectoryReader(segments_16:97:nrt _x(5.0):C8)}
[junit4:junit4]   1> 226417 [qtp523206750-38] 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> 226422 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testWaitOptions
[junit4:junit4]   1> 226453 [TEST-SolrExampleStreamingTest.testChineseDefaults-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testChineseDefaults
[junit4:junit4]   1> 226496 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@26c472b2 realtime
[junit4:junit4]   1> 226497 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554987438309376)} 0 3
[junit4:junit4]   1> 226505 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 226506 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_18,generation=44}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_19,generation=45}
[junit4:junit4]   1> 226506 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 45
[junit4:junit4]   1> 226507 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@43ce3b9f main
[junit4:junit4]   1> 226512 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@43ce3b9f main{StandardDirectoryReader(segments_18:99:nrt)}
[junit4:junit4]   1> 226512 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 226512 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 226515 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@43ce3b9f main{StandardDirectoryReader(segments_18:99:nrt)}
[junit4:junit4]   1> 226516 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 12
[junit4:junit4]   1> 226525 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1 
[junit4:junit4]   1> 226526 [TEST-SolrExampleStreamingTest.testChineseDefaults-seed#[684260099B060508]] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � blocking for commit/optimize
[junit4:junit4]   1> 226533 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 226535 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_19,generation=45}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1a,generation=46}
[junit4:junit4]   1> 226536 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 46
[junit4:junit4]   1> 226539 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1eb2ce16 main
[junit4:junit4]   1> 226540 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1eb2ce16 main{StandardDirectoryReader(segments_1a:101:nrt _y(5.0):C1)}
[junit4:junit4]   1> 226541 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 226541 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 226544 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1eb2ce16 main{StandardDirectoryReader(segments_1a:101:nrt _y(5.0):C1)}
[junit4:junit4]   1> 226545 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {add=[42 (1433554987477106688)],commit=} 0 14
[junit4:junit4]   1> 226552 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=????&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 226554 [TEST-SolrExampleStreamingTest.testChineseDefaults-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testChineseDefaults
[junit4:junit4]   1> 226611 [TEST-SolrExampleStreamingTest.testAddRetrieve-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testAddRetrieve
[junit4:junit4]   1> 226618 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@7a8c4f67 realtime
[junit4:junit4]   1> 226619 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554987565187072)} 0 4
[junit4:junit4]   1> 226622 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@658297f2
[junit4:junit4]   1> 226989 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id1 (1433554987578818560), id2 (1433554987580915712)]} 0 361
[junit4:junit4]   1> 226993 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id1 is 200
[junit4:junit4]   1> 226995 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@658297f2
[junit4:junit4]   1> 227003 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 227016 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1a,generation=46}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1b,generation=47}
[junit4:junit4]   1> 227018 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 47
[junit4:junit4]   1> 227025 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@2859bf79 main
[junit4:junit4]   1> 227028 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@2859bf79 main{StandardDirectoryReader(segments_1b:105:nrt _z(5.0):C2)}
[junit4:junit4]   1> 227030 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 227035 [qtp523206750-38] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 227038 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@2859bf79 main{StandardDirectoryReader(segments_1b:105:nrt _z(5.0):C2)}
[junit4:junit4]   1> 227040 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 37
[junit4:junit4]   1> 227048 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={sort=price+asc&q=*:*&wt=xml&version=2.2} hits=2 status=0 QTime=2 
[junit4:junit4]   1> 227080 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@51b145f
[junit4:junit4]   1> 227372 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id1 (1433554988060114944), id2 (1433554988065357824)]} 0 285
[junit4:junit4]   1> 227375 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id1 is 200
[junit4:junit4]   1> 227377 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@51b145f
[junit4:junit4]   1> 227384 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 227396 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1b,generation=47}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1c,generation=48}
[junit4:junit4]   1> 227399 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 48
[junit4:junit4]   1> 227403 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@48711f5a main
[junit4:junit4]   1> 227408 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@48711f5a main{StandardDirectoryReader(segments_1c:109:nrt _10(5.0):C2)}
[junit4:junit4]   1> 227409 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 227415 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@48711f5a main{StandardDirectoryReader(segments_1c:109:nrt _10(5.0):C2)}
[junit4:junit4]   1> 227416 [qtp523206750-35] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 227418 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 34
[junit4:junit4]   1> 227424 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={sort=price+asc&q=*:*&wt=xml&version=2.2} hits=2 status=0 QTime=1 
[junit4:junit4]   1> 227432 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={sort=price+asc&q=name:h?llo&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 227435 [TEST-SolrExampleStreamingTest.testAddRetrieve-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testAddRetrieve
[junit4:junit4]   1> 227452 [TEST-SolrExampleStreamingTest.testContentStreamRequest-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testContentStreamRequest
[junit4:junit4]   1> 227459 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@38176916 realtime
[junit4:junit4]   1> 227460 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554988447039488)} 0 5
[junit4:junit4]   1> 227468 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 227470 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1c,generation=48}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1d,generation=49}
[junit4:junit4]   1> 227471 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 49
[junit4:junit4]   1> 227473 [qtp523206750-33] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@2f0c37a9 main
[junit4:junit4]   1> 227475 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@2f0c37a9 main{StandardDirectoryReader(segments_1c:111:nrt)}
[junit4:junit4]   1> 227479 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 227481 [qtp523206750-33] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 227483 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@2f0c37a9 main{StandardDirectoryReader(segments_1c:111:nrt)}
[junit4:junit4]   1> 227484 [qtp523206750-33] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 16
[junit4:junit4]   1> 227490 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0 
[junit4:junit4]   1> 227588 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 227599 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1d,generation=49}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1e,generation=50}
[junit4:junit4]   1> 227599 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 50
[junit4:junit4]   1> 227602 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@5fc59667 main
[junit4:junit4]   1> 227606 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 227607 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@5fc59667 main{StandardDirectoryReader(segments_1e:113:nrt _11(5.0):C10)}
[junit4:junit4]   1> 227608 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 227610 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@5fc59667 main{StandardDirectoryReader(segments_1e:113:nrt _11(5.0):C10)}
[junit4:junit4]   1> 227611 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {add=[0553573403 (1433554988561334272), 0553579908 (1433554988566577152), 055357342X (1433554988567625728), 0553293354 (1433554988569722880), 0812521390 (1433554988571820032), 0812550706 (1433554988574965760), 0441385532 (1433554988577062912), 0380014300 (1433554988579160064), 0805080481 (1433554988581257216), 080508049X (1433554988584402944)],commit=} 0 99
[junit4:junit4]   1> 227623 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=10 status=0 QTime=1 
[junit4:junit4]   1> 227636 [TEST-SolrExampleStreamingTest.testContentStreamRequest-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testContentStreamRequest
[junit4:junit4]   1> 227664 [TEST-SolrExampleStreamingTest.testCommitWithinOnAdd-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testCommitWithinOnAdd
[junit4:junit4]   1> 227672 [qtp523206750-38] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@4b7185e8 realtime
[junit4:junit4]   1> 227673 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554988669337600)} 0 5
[junit4:junit4]   1> 227680 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 227681 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1e,generation=50}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1f,generation=51}
[junit4:junit4]   1> 227681 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 51
[junit4:junit4]   1> 227682 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1288fe70 main
[junit4:junit4]   1> 227685 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1288fe70 main{StandardDirectoryReader(segments_1e:115:nrt)}
[junit4:junit4]   1> 227702 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 227703 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1288fe70 main{StandardDirectoryReader(segments_1e:115:nrt)}
[junit4:junit4]   1> 227708 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 227708 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 28
[junit4:junit4]   1> 227715 [qtp523206750-33] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=2 
[junit4:junit4]   1> 227717 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e611d42
[junit4:junit4]   1> 227720 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0 
[junit4:junit4]   1> 228094 [qtp523206750-38] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id3 (1433554988740640768)]} 0 358
[junit4:junit4]   1> 228097 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id3 is 200
[junit4:junit4]   1> 228098 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e611d42
[junit4:junit4]   1> 228394 [commitScheduler-14-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> 228407 [commitScheduler-14-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@3e6e8796 main
[junit4:junit4]   1> 228408 [commitScheduler-14-thread-1] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 228409 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@3e6e8796 main{StandardDirectoryReader(segments_1f:117:nrt _12(5.0):C1)}
[junit4:junit4]   1> 228409 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 228410 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@3e6e8796 main{StandardDirectoryReader(segments_1f:117:nrt _12(5.0):C1)}
[junit4:junit4]   1> 228938 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=2 
[junit4:junit4]   1> 228945 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@8ff2ebd
[junit4:junit4]   1> 229266 [qtp523206750-34] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id4 (1433554990015709184)]} 0 315
[junit4:junit4]   1> 229269 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: id4 is 200
[junit4:junit4]   1> 229272 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@8ff2ebd
[junit4:junit4]   1> 229585 [commitScheduler-14-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> 229600 [commitScheduler-14-thread-1] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@265def14 main
[junit4:junit4]   1> 229601 [commitScheduler-14-thread-1] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 229601 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@265def14 main{StandardDirectoryReader(segments_1f:119:nrt _12(5.0):C1 _13(5.0):C1)}
[junit4:junit4]   1> 229603 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 229610 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@265def14 main{StandardDirectoryReader(segments_1f:119:nrt _12(5.0):C1 _13(5.0):C1)}
[junit4:junit4]   1> 230207 [qtp523206750-38] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=id:id4&wt=xml&version=2.2} hits=1 status=0 QTime=3 
[junit4:junit4]   1> 230214 [TEST-SolrExampleStreamingTest.testCommitWithinOnAdd-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testCommitWithinOnAdd
[junit4:junit4]   1> 230241 [TEST-SolrExampleStreamingTest.testPingHandler-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testPingHandler
[junit4:junit4]   1> 230250 [qtp523206750-35] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1fa7abb1 realtime
[junit4:junit4]   1> 230250 [qtp523206750-35] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1433554991373615104)} 0 3
[junit4:junit4]   1> 230257 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 230257 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1f,generation=51}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_1g,generation=52}
[junit4:junit4]   1> 230258 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 52
[junit4:junit4]   1> 230259 [qtp523206750-36] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@1a3836f1 main
[junit4:junit4]   1> 230262 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@1a3836f1 main{StandardDirectoryReader(segments_1f:121:nrt)}
[junit4:junit4]   1> 230263 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 230263 [qtp523206750-36] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 230267 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@1a3836f1 main{StandardDirectoryReader(segments_1f:121:nrt)}
[junit4:junit4]   1> 230268 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 11
[junit4:junit4]   1> 230274 [qtp523206750-34] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0 
[junit4:junit4]   1> 230316 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/admin/ping params={wt=xml&version=2.2} hits=0 status=0 QTime=19 
[junit4:junit4]   1> 230317 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/admin/ping params={wt=xml&version=2.2} status=0 QTime=22 
[junit4:junit4]   1> 230319 [TEST-SolrExampleStreamingTest.testPingHandler-seed#[684

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

j.impl.ConcurrentUpdateSolrServer$Runner@1611c34a
[junit4:junit4]   1> 236599 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4]   1> 236608 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_20,generation=72}
[junit4:junit4]   1> 	commit{dir=MockDirWrapper(RateLimitedDirectoryWrapper(org.apache.lucene.store.RAMDirectory@f2e624c lockFactory=org.apache.lucene.store.NativeFSLockFactory@4fe2355f)),segFN=segments_21,generation=73}
[junit4:junit4]   1> 236610 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � newest commit generation = 73
[junit4:junit4]   1> 236615 [qtp523206750-37] INFO  org.apache.solr.search.SolrIndexSearcher  � Opening Searcher@3fde7b88 main
[junit4:junit4]   1> 236619 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener sending requests to Searcher@3fde7b88 main{StandardDirectoryReader(segments_21:177:nrt _1i(5.0):C1)}
[junit4:junit4]   1> 236621 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � QuerySenderListener done.
[junit4:junit4]   1> 236623 [qtp523206750-37] INFO  org.apache.solr.update.UpdateHandler  � end_commit_flush
[junit4:junit4]   1> 236625 [searcherExecutor-11-thread-1] INFO  org.apache.solr.core.SolrCore  � [collection1] Registered new searcher Searcher@3fde7b88 main{StandardDirectoryReader(segments_21:177:nrt _1i(5.0):C1)}
[junit4:junit4]   1> 236626 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 28
[junit4:junit4]   1> 236632 [qtp523206750-38] 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=0 
[junit4:junit4]   1> 236641 [qtp523206750-33] 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=1 
[junit4:junit4]   1> 236643 [TEST-SolrExampleStreamingTest.testRealtimeGet-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testRealtimeGet
[junit4:junit4]   1> 236665 [TEST-SolrExampleStreamingTest.testErrorHandling-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Starting testErrorHandling
[junit4:junit4]   1> 236829 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � Ignoring exception matching ignore_exception
[junit4:junit4]   1> 236831 [qtp523206750-35] INFO  org.apache.solr.core.SolrCore  � [collection1] webapp=/solr path=/analysis/field params={analysis.fieldtype=int&wt=xml&qt=/analysis/field&analysis.fieldvalue=ignore_exception&version=2.2} status=400 QTime=161 
[junit4:junit4]   1> 237304 [qtp523206750-36] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 469
[junit4:junit4]   1> 237307 [qtp523206750-36] INFO  org.apache.solr.core.SolrCore  � Ignoring exception matching ignore_exception
[junit4:junit4]   1> 237309 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@226a690
[junit4:junit4]   1> 237313 [qtp523206750-37] INFO  org.apache.solr.update.processor.LogUpdateProcessor  � [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 0
[junit4:junit4]   1> 237314 [qtp523206750-37] INFO  org.apache.solr.core.SolrCore  � Ignoring exception matching uniqueKey
[junit4:junit4]   1> 237627 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � Status for: DOCID is 400
[junit4:junit4]   1> 237630 [concurrentUpdateScheduler-1-thread-6] INFO  org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer  � finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@226a690
[junit4:junit4]   1> 237631 [TEST-SolrExampleStreamingTest.testErrorHandling-seed#[684260099B060508]] INFO  org.apache.solr.SolrTestCaseJ4  � ###Ending testErrorHandling
[junit4:junit4]   1> 237654 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CoreContainer  � Shutting down CoreContainer instance=1751618666
[junit4:junit4]   1> 237657 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCore  � [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@74617c53
[junit4:junit4]   1> 237704 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.update.UpdateHandler  � closing DirectUpdateHandler2{commits=67,autocommit maxTime=15000ms,autocommits=1,soft autocommits=3,optimizes=8,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=1,cumulative_adds=150,cumulative_deletesById=5,cumulative_deletesByQuery=27,cumulative_errors=1}
[junit4:junit4]   1> 237706 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.update.SolrCoreState  � Closing SolrCoreState
[junit4:junit4]   1> 237707 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.update.DefaultSolrCoreState  � SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4]   1> 237708 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.update.DefaultSolrCoreState  � closing IndexWriter with IndexWriterCloser
[junit4:junit4]   1> 237715 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.SolrCore  � [collection1] Closing main searcher on request.
[junit4:junit4]   1> 237717 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  � Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4:junit4]   1> 237717 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  � looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\;done=false>>]
[junit4:junit4]   1> 237718 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  � Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\
[junit4:junit4]   1> 237718 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  � looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index;done=false>>]
[junit4:junit4]   1> 237719 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.core.CachingDirectoryFactory  � Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingTest-1367144357284\index
[junit4:junit4]   1> 237721 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.eclipse.jetty.server.handler.ContextHandler  � stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4]   1> 237778 [SUITE-SolrExampleStreamingTest-seed#[684260099B060508]-worker] INFO  org.apache.solr.SolrTestCaseJ4  � ###deleteCore
[junit4:junit4]   2> NOTE: test params are: codec=Lucene41, sim=DefaultSimilarity, locale=no, timezone=Asia/Brunei
[junit4:junit4]   2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_21 (64-bit)/cpus=2,threads=6,free=133423920,total=279969792
[junit4:junit4]   2> NOTE: All tests run in this JVM: [JettyWebappTest, SolrExampleStreamingTest]
[junit4:junit4] Completed in 227.00s, 27 tests, 1 error <<< FAILURES!

[...truncated 140 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:378: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:358: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:39: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:194: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:437: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1240: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:884: There were test failures: 45 suites, 268 tests, 1 error, 1 ignored (1 assumption)

Total time: 72 minutes 28 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_21 -XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure



Mime
View raw message