You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2013/07/20 23:10:23 UTC
[JENKINS] Lucene-Solr-trunk-Windows (64bit/jdk1.7.0_25) - Build #
3052 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/3052/
Java: 64bit/jdk1.7.0_25 -XX:+UseCompressedOops -XX:+UseSerialGC
1 tests failed.
REGRESSION: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest.testMultiContentStreamRequest
Error Message:
IOException occured when talking to server at: https://127.0.0.1:61784/solr/collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:61784/solr/collection1
at __randomizedtesting.SeedInfo.seed([C680F8F72705BF0A:29B4D5C57955E703]: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.testMultiContentStreamRequest(SolrExampleTests.java:694)
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:606)
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:724)
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 10554 lines...]
[junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingBinaryTest
[junit4] 1> 82935 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.SolrJettyTestBase – Randomized ssl (true) and clientAuth (false)
[junit4] 1> 82937 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ####initCore
[junit4] 1> 82938 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ####initCore end
[junit4] 1> 82939 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.eclipse.jetty.server.Server – jetty-8.1.10.v20130312
[junit4] 1> 82952 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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] 1> 82960 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.eclipse.jetty.server.AbstractConnector – Started SslSelectChannelConnector@127.0.0.1:61784
[junit4] 1> 82961 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – SolrDispatchFilter.init()
[junit4] 1> 82961 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.SolrResourceLoader – JNDI not configured for solr (NoInitialContextEx)
[junit4] 1> 82961 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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] 1> 82962 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.SolrResourceLoader – new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\'
[junit4] 1> 83002 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.ConfigSolr – Loading container configuration from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\solr.xml
[junit4] 1> 83123 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.ConfigSolrXml – Config-defined core root directory:
[junit4] 1> 83123 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoreContainer – New CoreContainer 430251425
[junit4] 1> 83124 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoreContainer – Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\]
[junit4] 1> 83126 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting socketTimeout to: 0
[junit4] 1> 83126 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting urlScheme to: http://
[junit4] 1> 83127 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting connTimeout to: 0
[junit4] 1> 83127 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maxConnectionsPerHost to: 20
[junit4] 1> 83129 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting corePoolSize to: 0
[junit4] 1> 83129 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maximumPoolSize to: 2147483647
[junit4] 1> 83130 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maxThreadIdleTime to: 5
[junit4] 1> 83130 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting sizeOfQueue to: -1
[junit4] 1> 83130 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting fairnessPolicy to: false
[junit4] 1> 83131 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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] 1> 83135 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.logging.LogWatcher – Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 1> 83143 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoresLocator – Looking for core definitions underneath C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr
[junit4] 1> 83168 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoresLocator – Found core collection1 in C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\example\solr\collection1\
[junit4] 1> 83170 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoresLocator – Found 1 core definitions
[junit4] 1> 83171 [coreLoadExecutor-64-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] 1> 83173 [coreLoadExecutor-64-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] 1> 83243 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrConfig – Adding specified lib dirs to ClassLoader
[junit4] 1> 83245 [coreLoadExecutor-64-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] 1> 83245 [coreLoadExecutor-64-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] 1> 83248 [coreLoadExecutor-64-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] 1> 83248 [coreLoadExecutor-64-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] 1> 83249 [coreLoadExecutor-64-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] 1> 83249 [coreLoadExecutor-64-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] 1> 83250 [coreLoadExecutor-64-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] 1> 83250 [coreLoadExecutor-64-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] 1> 83318 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.update.SolrIndexConfig – IndexWriter infoStream solr logging is enabled
[junit4] 1> 83325 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrConfig – Using Lucene MatchVersion: LUCENE_50
[junit4] 1> 83445 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.Config – Loaded SolrConfig: solrconfig.xml
[junit4] 1> 83446 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.schema.IndexSchema – Reading Solr Schema from schema.xml
[junit4] 1> 83497 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.schema.IndexSchema – [collection1] Schema name=example
[junit4] 1> 84632 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.schema.IndexSchema – unique key field: id
[junit4] 1> 84665 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider – Reloading exchange rates from file currency.xml
[junit4] 1> 84674 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider – Reloading exchange rates from file currency.xml
[junit4] 1> 84759 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – org.apache.solr.core.MockDirectoryFactory
[junit4] 1> 84760 [coreLoadExecutor-64-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-SolrExampleStreamingBinaryTest-1374354270878\
[junit4] 1> 84760 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.JmxMonitoredMap – JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@5a7e7376
[junit4] 1> 84769 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 1> 84769 [coreLoadExecutor-64-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] 1> 84769 [coreLoadExecutor-64-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-SolrExampleStreamingBinaryTest-1374354270878\
[junit4] 1> 84771 [coreLoadExecutor-64-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-SolrExampleStreamingBinaryTest-1374354270878\index/
[junit4] 1> 84771 [coreLoadExecutor-64-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-SolrExampleStreamingBinaryTest-1374354270878\index' doesn't exist. Creating new index...
[junit4] 1> 84771 [coreLoadExecutor-64-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-SolrExampleStreamingBinaryTest-1374354270878\index
[junit4] 1> 84775 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_1,generation=1}
[junit4] 1> 84775 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – newest commit generation = 1
[junit4] 1> 84776 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – created json: solr.JSONResponseWriter
[junit4] 1> 84776 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4] 1> 84777 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – created velocity: solr.VelocityResponseWriter
[junit4] 1> 84777 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – created xslt: solr.XSLTResponseWriter
[junit4] 1> 84777 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.response.XSLTResponseWriter – xsltCacheLifetimeSeconds=5
[junit4] 1> 84792 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /select: solr.SearchHandler
[junit4] 1> 84795 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /query: solr.SearchHandler
[junit4] 1> 84795 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /get: solr.RealTimeGetHandler
[junit4] 1> 84796 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /browse: solr.SearchHandler
[junit4] 1> 84797 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update: solr.UpdateRequestHandler
[junit4] 1> 84798 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/json: solr.JsonUpdateRequestHandler
[junit4] 1> 84800 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/csv: solr.CSVRequestHandler
[junit4] 1> 84800 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4] 1> 84800 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4] 1> 84800 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4] 1> 84801 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4] 1> 84802 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4] 1> 84802 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4] 1> 84803 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /admin/: solr.admin.AdminHandlers
[junit4] 1> 84803 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /admin/ping: solr.PingRequestHandler
[junit4] 1> 84804 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /debug/dump: solr.DumpRequestHandler
[junit4] 1> 84806 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /replication: solr.ReplicationHandler
[junit4] 1> 84806 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4] 1> 84806 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /spell: solr.SearchHandler
[junit4] 1> 84807 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4] 1> 84807 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /tvrh: solr.SearchHandler
[junit4] 1> 84808 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4] 1> 84808 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /terms: solr.SearchHandler
[junit4] 1> 84809 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4] 1> 84809 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.RequestHandlers – created /elevate: solr.SearchHandler
[junit4] 1> 84820 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4] 1> 84821 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4] 1> 84824 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4] 1> 84833 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@72885e8c main
[junit4] 1> 84835 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – Hard AutoCommit: if uncommited for 15000ms;
[junit4] 1> 84835 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.SolrCore – Soft AutoCommit: disabled
[junit4] 1> 84836 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Initializing spell checkers
[junit4] 1> 84837 [coreLoadExecutor-64-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] 1> 84837 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – No queryConverter defined, using default converter
[junit4] 1> 84839 [coreLoadExecutor-64-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] 1> 84878 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.handler.ReplicationHandler – Commits will be reserved for 10000
[junit4] 1> 84879 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@72885e8c main{StandardDirectoryReader(segments_1:1)}
[junit4] 1> 84881 [searcherExecutor-65-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] 1> 84881 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 84881 [searcherExecutor-65-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Loading spell index for spellchecker: default
[junit4] 1> 84881 [searcherExecutor-65-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Loading spell index for spellchecker: wordbreak
[junit4] 1> 84893 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@72885e8c main{StandardDirectoryReader(segments_1:1)}
[junit4] 1> 84912 [coreLoadExecutor-64-thread-1] INFO org.apache.solr.core.CoreContainer – registering core: collection1
[junit4] 1> 84913 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – user.dir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0
[junit4] 1> 84913 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – SolrDispatchFilter.init() done
[junit4] 1> 84913 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.SolrJettyTestBase – Jetty Assigned Port#61784
[junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\.\solrtest-SolrExampleStreamingBinaryTest-1374354270878
[junit4] 1> 84925 [TEST-SolrExampleStreamingBinaryTest.testChineseDefaults-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testChineseDefaults
[junit4] 1> 84925 [TEST-SolrExampleStreamingBinaryTest.testChineseDefaults-seed#[C680F8F72705BF0A]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 1> 85006 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onInit: commits: num=1
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_1,generation=1}
[junit4] 1> 85009 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – newest commit generation = 1
[junit4] 1> 85012 [qtp354082693-177] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7942e524 realtime
[junit4] 1> 85015 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441114906106527744)} 0 20
[junit4] 1> 85022 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85023 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – No uncommitted changes. Skipping IW.commit.
[junit4] 1> 85026 [qtp354082693-178] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@701ee825 main
[junit4] 1> 85028 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85028 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@701ee825 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 1> 85029 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85042 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@701ee825 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 1> 85045 [qtp354082693-178] 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 23
[junit4] 1> 85054 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 1> 85058 [TEST-SolrExampleStreamingBinaryTest.testChineseDefaults-seed#[C680F8F72705BF0A]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – blocking for commit/optimize
[junit4] 1> 85069 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85076 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_1,generation=1}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_2,generation=2}
[junit4] 1> 85077 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – newest commit generation = 2
[junit4] 1> 85081 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@454a9c27 main
[junit4] 1> 85083 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85083 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@454a9c27 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C1)}
[junit4] 1> 85085 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85100 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@454a9c27 main{StandardDirectoryReader(segments_2:3:nrt _0(5.0):C1)}
[junit4] 1> 85103 [qtp354082693-180] 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 (1441114906170490880)],commit=} 0 40
[junit4] 1> 85114 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=????&wt=javabin&version=2} hits=1 status=0 QTime=3
[junit4] 1> 85118 [TEST-SolrExampleStreamingBinaryTest.testChineseDefaults-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testChineseDefaults
[junit4] 1> 85145 [TEST-SolrExampleStreamingBinaryTest.testExampleConfig-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testExampleConfig
[junit4] 1> 85157 [qtp354082693-176] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@42d01e76 realtime
[junit4] 1> 85158 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441114906261716992)} 0 7
[junit4] 1> 85162 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2fb710a3
[junit4] 1> 85454 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[1112211111 (1441114906283737088)]} 0 282
[junit4] 1> 85457 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 1112211111 is 200
[junit4] 1> 85459 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2fb710a3
[junit4] 1> 85465 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85471 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_2,generation=2}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_3,generation=3}
[junit4] 1> 85472 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – newest commit generation = 3
[junit4] 1> 85477 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@5b72c7f4 main
[junit4] 1> 85479 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85479 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@5b72c7f4 main{StandardDirectoryReader(segments_3:7:nrt _1(5.0):C1)}
[junit4] 1> 85480 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85494 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@5b72c7f4 main{StandardDirectoryReader(segments_3:7:nrt _1(5.0):C1)}
[junit4] 1> 85497 [qtp354082693-179] 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 32
[junit4] 1> 85505 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85514 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_3,generation=3}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_4,generation=4}
[junit4] 1> 85515 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – newest commit generation = 4
[junit4] 1> 85519 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4f03844f main
[junit4] 1> 85520 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85520 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@4f03844f main{StandardDirectoryReader(segments_4:9:nrt _2(5.0):C1)}
[junit4] 1> 85523 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85535 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@4f03844f main{StandardDirectoryReader(segments_4:9:nrt _2(5.0):C1)}
[junit4] 1> 85539 [qtp354082693-180] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {optimize=} 0 34
[junit4] 1> 85548 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:1112211111&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4] 1> 85554 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@470d3fec
[junit4] 1> 85846 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[2 (1441114906694778880), 3 (1441114906713653248), 4 (1441114906715750400), 5 (1441114906717847552)]} 0 283
[junit4] 1> 85849 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 2 is 200
[junit4] 1> 85851 [concurrentUpdateScheduler-4-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@470d3fec
[junit4] 1> 85857 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85867 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_4,generation=4}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_5,generation=5}
[junit4] 1> 85869 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – newest commit generation = 5
[junit4] 1> 85873 [qtp354082693-178] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7ea26476 main
[junit4] 1> 85874 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85874 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@7ea26476 main{StandardDirectoryReader(segments_5:11:nrt _2(5.0):C1 _3(5.0):C4)}
[junit4] 1> 85876 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85889 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@7ea26476 main{StandardDirectoryReader(segments_5:11:nrt _2(5.0):C1 _3(5.0):C4)}
[junit4] 1> 85910 [qtp354082693-178] 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 53
[junit4] 1> 85917 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 85924 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_5,generation=5}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_6,generation=6}
[junit4] 1> 85924 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – newest commit generation = 6
[junit4] 1> 85927 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@45589605 main
[junit4] 1> 85928 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 85928 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@45589605 main{StandardDirectoryReader(segments_6:13:nrt _4(5.0):C5)}
[junit4] 1> 85929 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 85932 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@45589605 main{StandardDirectoryReader(segments_6:13:nrt _4(5.0):C5)}
[junit4] 1> 85934 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {optimize=} 0 18
[junit4] 1> 85952 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&wt=javabin&version=2} hits=5 status=0 QTime=12
[junit4] 1> 85963 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&wt=javabin&fq=inStock:true&version=2} hits=2 status=0 QTime=4
[junit4] 1> 85973 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&q=foo&wt=javabin&fq={!field+f%3DinStock}true&fq={!term+f%3Dname}hoss&version=2} hits=0 status=0 QTime=4
[junit4] 1> 85974 [TEST-SolrExampleStreamingBinaryTest.testExampleConfig-seed#[C680F8F72705BF0A]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 1> 86011 [qtp354082693-179] INFO org.apache.solr.servlet.SolrDispatchFilter – [admin] webapp=null path=/admin/info/system params={wt=javabin&qt=/admin/info/system&version=2} status=0 QTime=1
[junit4] 1> 86013 [TEST-SolrExampleStreamingBinaryTest.testExampleConfig-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testExampleConfig
[junit4] 1> 86027 [TEST-SolrExampleStreamingBinaryTest.testMultiContentStreamRequest-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testMultiContentStreamRequest
[junit4] 1> 86032 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@41bd058e realtime
[junit4] 1> 86033 [qtp354082693-180] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441114907183415296)} 0 3
[junit4] 1> 102133 [commitScheduler-67-thread-1] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 102135 [commitScheduler-67-thread-1] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_6,generation=6}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_7,generation=7}
[junit4] 1> 102135 [commitScheduler-67-thread-1] INFO org.apache.solr.core.SolrCore – newest commit generation = 7
[junit4] 1> 102138 [commitScheduler-67-thread-1] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 286115 [TEST-SolrExampleStreamingBinaryTest.testMultiContentStreamRequest-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testMultiContentStreamRequest
[junit4] 1> 286117 [qtp354082693-181] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 286117 [qtp354082693-181] INFO org.apache.solr.update.UpdateHandler – No uncommitted changes. Skipping IW.commit.
[junit4] 1> 286118 [qtp354082693-181] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@ffd651d main
[junit4] 1> 286119 [qtp354082693-181] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 286119 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@ffd651d main{StandardDirectoryReader(segments_6:15:nrt)}
[junit4] 1> 286120 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 286129 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@ffd651d main{StandardDirectoryReader(segments_6:15:nrt)}
[junit4] 1> 286130 [qtp354082693-181] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 13
[junit4] 1> 286132 [qtp354082693-181] ERROR org.apache.solr.servlet.SolrDispatchFilter – null:org.eclipse.jetty.io.EofException
[junit4] 1> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:142)
[junit4] 1> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
[junit4] 1> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:214)
[junit4] 1> at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:207)
[junit4] 1> at org.apache.solr.common.util.JavaBinCodec.marshal(JavaBinCodec.java:94)
[junit4] 1> at org.apache.solr.response.BinaryResponseWriter.write(BinaryResponseWriter.java:52)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.writeResponse(SolrDispatchFilter.java:647)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:158)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 1> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:136)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 1> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 1> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 1> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 1> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 1> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 1> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 1> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 1> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 1> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:953)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1014)
[junit4] 1> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
[junit4] 1> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:240)
[junit4] 1> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 1> at org.eclipse.jetty.io.nio.SslConnection.handle(SslConnection.java:196)
[junit4] 1> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 1> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 1> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 1> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 1> at java.lang.Thread.run(Thread.java:724)
[junit4] 1>
[junit4] 1> 286135 [qtp354082693-181] ERROR org.apache.solr.servlet.SolrDispatchFilter – null:org.eclipse.jetty.io.EofException
[junit4] 1> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:142)
[junit4] 1> at org.eclipse.jetty.server.HttpOutput.write(HttpOutput.java:107)
[junit4] 1> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:214)
[junit4] 1> at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:207)
[junit4] 1> at org.apache.solr.common.util.JavaBinCodec.marshal(JavaBinCodec.java:94)
[junit4] 1> at org.apache.solr.response.BinaryResponseWriter.write(BinaryResponseWriter.java:52)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.writeResponse(SolrDispatchFilter.java:647)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:382)
[junit4] 1> at org.apache.solr.servlet.SolrDispatchFilter.doFilter(SolrDispatchFilter.java:158)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 1> at org.apache.solr.client.solrj.embedded.JettySolrRunner$DebugFilter.doFilter(JettySolrRunner.java:136)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler$CachedChain.doFilter(ServletHandler.java:1419)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler.doHandle(ServletHandler.java:455)
[junit4] 1> at org.eclipse.jetty.server.session.SessionHandler.doHandle(SessionHandler.java:229)
[junit4] 1> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:137)
[junit4] 1> at org.eclipse.jetty.server.handler.GzipHandler.handle(GzipHandler.java:301)
[junit4] 1> at org.eclipse.jetty.server.handler.ContextHandler.doHandle(ContextHandler.java:1077)
[junit4] 1> at org.eclipse.jetty.servlet.ServletHandler.doScope(ServletHandler.java:384)
[junit4] 1> at org.eclipse.jetty.server.session.SessionHandler.doScope(SessionHandler.java:193)
[junit4] 1> at org.eclipse.jetty.server.handler.ContextHandler.doScope(ContextHandler.java:1009)
[junit4] 1> at org.eclipse.jetty.server.handler.ScopedHandler.handle(ScopedHandler.java:135)
[junit4] 1> at org.eclipse.jetty.server.handler.HandlerWrapper.handle(HandlerWrapper.java:116)
[junit4] 1> at org.eclipse.jetty.server.Server.handle(Server.java:368)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection.handleRequest(AbstractHttpConnection.java:489)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection.content(AbstractHttpConnection.java:953)
[junit4] 1> at org.eclipse.jetty.server.AbstractHttpConnection$RequestHandler.content(AbstractHttpConnection.java:1014)
[junit4] 1> at org.eclipse.jetty.http.HttpParser.parseNext(HttpParser.java:861)
[junit4] 1> at org.eclipse.jetty.http.HttpParser.parseAvailable(HttpParser.java:240)
[junit4] 1> at org.eclipse.jetty.server.AsyncHttpConnection.handle(AsyncHttpConnection.java:82)
[junit4] 1> at org.eclipse.jetty.io.nio.SslConnection.handle(SslConnection.java:196)
[junit4] 1> at org.eclipse.jetty.io.nio.SelectChannelEndPoint.handle(SelectChannelEndPoint.java:628)
[junit4] 1> at org.eclipse.jetty.io.nio.SelectChannelEndPoint$1.run(SelectChannelEndPoint.java:52)
[junit4] 1> at org.eclipse.jetty.util.thread.QueuedThreadPool.runJob(QueuedThreadPool.java:608)
[junit4] 1> at org.eclipse.jetty.util.thread.QueuedThreadPool$3.run(QueuedThreadPool.java:543)
[junit4] 1> at java.lang.Thread.run(Thread.java:724)
[junit4] 1>
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrExampleStreamingBinaryTest -Dtests.method=testMultiContentStreamRequest -Dtests.seed=C680F8F72705BF0A -Dtests.slow=true -Dtests.locale=de_AT -Dtests.timezone=America/Montreal -Dtests.file.encoding=UTF-8
[junit4] ERROR 200s | SolrExampleStreamingBinaryTest.testMultiContentStreamRequest <<<
[junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:61784/solr/collection1
[junit4] > at __randomizedtesting.SeedInfo.seed([C680F8F72705BF0A:29B4D5C57955E703]:0)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4] > at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer.request(ConcurrentUpdateSolrServer.java:256)
[junit4] > at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4] > at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
[junit4] > at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
[junit4] > at org.apache.solr.client.solrj.SolrExampleTests.testMultiContentStreamRequest(SolrExampleTests.java:694)
[junit4] > at java.lang.Thread.run(Thread.java:724)
[junit4] > Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
[junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
[junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
[junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
[junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
[junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
[junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
[junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4] > ... 46 more
[junit4] 1> 286228 [TEST-SolrExampleStreamingBinaryTest.testRealtimeGet-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testRealtimeGet
[junit4] 1> 286241 [qtp354082693-180] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115117117767680)} 0 2
[junit4] 1> 286244 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@572ae69a
[junit4] 1> 286558 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[DOCID (1441115117128253440)]} 0 309
[junit4] 1> 286561 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: DOCID is 200
[junit4] 1> 286562 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@572ae69a
[junit4] 1> 286566 [qtp354082693-181] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 286569 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_7,generation=7}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_8,generation=8}
[junit4] 1> 286569 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – newest commit generation = 8
[junit4] 1> 286572 [qtp354082693-181] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3a018bc main
[junit4] 1> 286573 [qtp354082693-181] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 286573 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3a018bc main{StandardDirectoryReader(segments_8:17:nrt _5(5.0):C1)}
[junit4] 1> 286573 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 286580 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3a018bc main{StandardDirectoryReader(segments_8:17:nrt _5(5.0):C1)}
[junit4] 1> 286581 [qtp354082693-181] 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 15
[junit4] 1> 286591 [qtp354082693-176] 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=2
[junit4] 1> 286601 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/get params={id=DOCID&fl=id,name,aaa:[value+v%3Daaa]&wt=xml&qt=/get&version=2.2} status=0 QTime=2
[junit4] 1> 286603 [TEST-SolrExampleStreamingBinaryTest.testRealtimeGet-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testRealtimeGet
[junit4] 1> 286616 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testUpdateRequestWithParameters
[junit4] 1> 286618 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[C680F8F72705BF0A]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4] 1> 286659 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@388e189f realtime
[junit4] 1> 286659 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115117555023872)} 0 3
[junit4] 1> 286665 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 286665 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_8,generation=8}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_9,generation=9}
[junit4] 1> 286666 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – newest commit generation = 9
[junit4] 1> 286667 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@78d2df8c main
[junit4] 1> 286668 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@78d2df8c main{StandardDirectoryReader(segments_8:19:nrt)}
[junit4] 1> 286668 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 286668 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 286673 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@78d2df8c main{StandardDirectoryReader(segments_8:19:nrt)}
[junit4] 1> 286676 [qtp354082693-179] 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 11
[junit4] 1> 286678 [concurrentUpdateScheduler-5-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@155767ad
[junit4] 1> 286678 [concurrentUpdateScheduler-5-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@28fb09fc
[junit4] 1> 286679 [concurrentUpdateScheduler-5-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@e936760
[junit4] 1> 286679 [concurrentUpdateScheduler-5-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2eabc310
[junit4] 1> 286685 [concurrentUpdateScheduler-5-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2eabc310
[junit4] 1> 286679 [concurrentUpdateScheduler-5-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6f33c0a1
[junit4] 1> 286688 [concurrentUpdateScheduler-5-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6f33c0a1
[junit4] 1> 286683 [concurrentUpdateScheduler-5-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@e936760
[junit4] 1> 286999 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={overwrite=false&wt=javabin&version=2} {add=[id1 (1441115117591724032)]} 0 309
[junit4] 1> 287001 [concurrentUpdateScheduler-5-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id1 is 200
[junit4] 1> 287001 [concurrentUpdateScheduler-5-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@155767ad
[junit4] 1> 287005 [qtp354082693-178] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={overwrite=false&wt=javabin&version=2} {add=[id1 (1441115117594869760)]} 0 311
[junit4] 1> 287006 [concurrentUpdateScheduler-5-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id1 is 200
[junit4] 1> 287007 [concurrentUpdateScheduler-5-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@28fb09fc
[junit4] 1> 287015 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 287019 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_9,generation=9}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_a,generation=10}
[junit4] 1> 287021 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – newest commit generation = 10
[junit4] 1> 287023 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@504b5f9a main
[junit4] 1> 287025 [qtp354082693-179] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 287050 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@504b5f9a main{StandardDirectoryReader(segments_a:21:nrt _6(5.0):C2)}
[junit4] 1> 287050 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 287055 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@504b5f9a main{StandardDirectoryReader(segments_a:21:nrt _6(5.0):C2)}
[junit4] 1> 287056 [qtp354082693-179] 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 41
[junit4] 1> 287067 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=3
[junit4] 1> 287069 [TEST-SolrExampleStreamingBinaryTest.testUpdateRequestWithParameters-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testUpdateRequestWithParameters
[junit4] 1> 287084 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdates-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testSetNullUpdates
[junit4] 1> 287229 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a829abf
[junit4] 1> 287542 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdates (1441115118159003648)]} 0 310
[junit4] 1> 287545 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdates is 200
[junit4] 1> 287545 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7a829abf
[junit4] 1> 287551 [qtp354082693-176] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 287565 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_a,generation=10}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_b,generation=11}
[junit4] 1> 287566 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – newest commit generation = 11
[junit4] 1> 287569 [qtp354082693-176] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@5bb97f04 main
[junit4] 1> 287571 [qtp354082693-176] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 287571 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@5bb97f04 main{StandardDirectoryReader(segments_b:23:nrt _6(5.0):C2 _7(5.0):C1)}
[junit4] 1> 287572 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 287576 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@5bb97f04 main{StandardDirectoryReader(segments_b:23:nrt _6(5.0):C2 _7(5.0):C1)}
[junit4] 1> 287579 [qtp354082693-176] 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 30
[junit4] 1> 287580 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6f420ea7
[junit4] 1> 287893 [qtp354082693-181] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[testSetNullUpdates (1441115118529150976)]} 0 310
[junit4] 1> 287896 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdates is 200
[junit4] 1> 287897 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6f420ea7
[junit4] 1> 287904 [qtp354082693-177] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 287908 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_b,generation=11}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_c,generation=12}
[junit4] 1> 287909 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – newest commit generation = 12
[junit4] 1> 287911 [qtp354082693-177] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7d3f3a4c main
[junit4] 1> 287913 [qtp354082693-177] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 287913 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@7d3f3a4c main{StandardDirectoryReader(segments_c:27:nrt _6(5.0):C2 _8(5.0):C1)}
[junit4] 1> 287914 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 287922 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@7d3f3a4c main{StandardDirectoryReader(segments_c:27:nrt _6(5.0):C2 _8(5.0):C1)}
[junit4] 1> 287925 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 22
[junit4] 1> 287933 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdates&wt=javabin&version=2} hits=1 status=0 QTime=4
[junit4] 1> 287937 [TEST-SolrExampleStreamingBinaryTest.testSetNullUpdates-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testSetNullUpdates
[junit4] 1> 287952 [TEST-SolrExampleStreamingBinaryTest.testCommitWithinOnDelete-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testCommitWithinOnDelete
[junit4] 1> 287960 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@169c0c37 realtime
[junit4] 1> 287961 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115118919221248)} 0 4
[junit4] 1> 287965 [qtp354082693-176] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 287966 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_c,generation=12}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_d,generation=13}
[junit4] 1> 287967 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – newest commit generation = 13
[junit4] 1> 287967 [qtp354082693-176] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@296e455e main
[junit4] 1> 287968 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@296e455e main{StandardDirectoryReader(segments_c:29:nrt)}
[junit4] 1> 287968 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 287969 [qtp354082693-176] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 287974 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@296e455e main{StandardDirectoryReader(segments_c:29:nrt)}
[junit4] 1> 287975 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4] 1> 287980 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 1> 287983 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e8db999
[junit4] 1> 288295 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id3 (1441115118949629952)]} 0 310
[junit4] 1> 288300 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id3 is 200
[junit4] 1> 288301 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5e8db999
[junit4] 1> 288306 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 288314 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_d,generation=13}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_e,generation=14}
[junit4] 1> 288317 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – newest commit generation = 14
[junit4] 1> 288326 [qtp354082693-178] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@ecd4c33 main
[junit4] 1> 288337 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@ecd4c33 main{StandardDirectoryReader(segments_e:31:nrt _9(5.0):C1)}
[junit4] 1> 288337 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 288339 [qtp354082693-178] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 288346 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@ecd4c33 main{StandardDirectoryReader(segments_e:31:nrt _9(5.0):C1)}
[junit4] 1> 288348 [qtp354082693-178] 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 42
[junit4] 1> 288357 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=3
[junit4] 1> 288365 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {delete=[id3 (-1441115119344943104)]} 0 2
[junit4] 1> 288370 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 1> 288686 [qtp354082693-177] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 1> 289001 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=0
[junit4] 1> 289316 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=1 status=0 QTime=1
[junit4] 1> 289603 [commitScheduler-68-thread-1] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 1> 289604 [commitScheduler-68-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3d0ad13e main
[junit4] 1> 289606 [commitScheduler-68-thread-1] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 289606 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3d0ad13e main{StandardDirectoryReader(segments_e:33:nrt)}
[junit4] 1> 289607 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 289610 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3d0ad13e main{StandardDirectoryReader(segments_e:33:nrt)}
[junit4] 1> 289635 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=javabin&version=2} hits=0 status=0 QTime=2
[junit4] 1> 289637 [TEST-SolrExampleStreamingBinaryTest.testCommitWithinOnDelete-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testCommitWithinOnDelete
[junit4] 1> 289653 [TEST-SolrExampleStreamingBinaryTest.testPingHandler-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testPingHandler
[junit4] 1> 289658 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115120702849024)} 0 0
[junit4] 1> 289664 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 289665 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_e,generation=14}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_f,generation=15}
[junit4] 1> 289665 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – newest commit generation = 15
[junit4] 1> 289666 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@78d007cb main
[junit4] 1> 289667 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@78d007cb main{StandardDirectoryReader(segments_e:33:nrt)}
[junit4] 1> 289667 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 289669 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 289673 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@78d007cb main{StandardDirectoryReader(segments_e:33:nrt)}
[junit4] 1> 289675 [qtp354082693-180] 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 11
[junit4] 1> 289682 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2} hits=0 status=0 QTime=0
[junit4] 1> 289689 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/admin/ping params={wt=javabin&version=2} hits=0 status=0 QTime=1
[junit4] 1> 289690 [qtp354082693-179] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/admin/ping params={wt=javabin&version=2} status=0 QTime=2
[junit4] 1> 289692 [TEST-SolrExampleStreamingBinaryTest.testPingHandler-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testPingHandler
[junit4] 1> 289716 [TEST-SolrExampleStreamingBinaryTest.testAddRetrieve-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testAddRetrieve
[junit4] 1> 289727 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115120772055040)} 0 3
[junit4] 1> 289757 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@51ec5bba
[junit4] 1> 290073 [qtp354082693-181] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id1 (1441115120813998080), id2 (1441115120818192384)]} 0 309
[junit4] 1> 290076 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id1 is 200
[junit4] 1> 290078 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@51ec5bba
[junit4] 1> 290081 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 290092 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_f,generation=15}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_g,generation=16}
[junit4] 1> 290093 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – newest commit generation = 16
[junit4] 1> 290095 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@69c9f46a main
[junit4] 1> 290095 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@69c9f46a main{StandardDirectoryReader(segments_g:35:nrt _a(5.0):C2)}
[junit4] 1> 290095 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 290103 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@69c9f46a main{StandardDirectoryReader(segments_g:35:nrt _a(5.0):C2)}
[junit4] 1> 290107 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 290107 [qtp354082693-180] 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 26
[junit4] 1> 290119 [qtp354082693-178] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={sort=price+asc&q=*:*&wt=javabin&version=2} hits=2 status=0 QTime=5
[junit4] 1> 290200 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@560e35c5
[junit4] 1> 290516 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[id1 (1441115121276420096), id2 (1441115121282711552)]} 0 311
[junit4] 1> 290518 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id1 is 200
[junit4] 1> 290519 [concurrentUpdateScheduler-4-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServ
[...truncated too long message...]
d-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 303114 [qtp354082693-176] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 303116 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@4efb8be6 main{StandardDirectoryReader(segments_1s:173:nrt _1j(5.0):C3)}
[junit4] 1> 303117 [qtp354082693-176] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 10
[junit4] 1> 303125 [qtp354082693-181] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=3} hits=3 status=0 QTime=1
[junit4] 1> 303133 [qtp354082693-179] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@72501d2c realtime
[junit4] 1> 303133 [qtp354082693-179] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {deleteByQuery=*:* (-1441115134830313472)} 0 2
[junit4] 1> 303135 [concurrentUpdateScheduler-4-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@69ab6e55
[junit4] 1> 303414 [qtp354082693-177] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=javabin&version=2} {add=[0 (1441115134838702080), 1 (1441115134840799232), 2 (1441115134842896384), 3 (1441115134842896385), 4 (1441115134843944960), 5 (1441115134844993536), 6 (1441115134844993537), 7 (1441115134846042112), 8 (1441115134846042113)]} 0 275
[junit4] 1> 303416 [concurrentUpdateScheduler-4-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4] 1> 303417 [concurrentUpdateScheduler-4-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@69ab6e55
[junit4] 1> 303421 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 1> 303427 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_1s,generation=64}
[junit4] 1> commit{dir=MockDirWrapper(org.apache.lucene.store.RAMDirectory@637305e0 lockFactory=org.apache.lucene.store.NativeFSLockFactory@12b77406),segFN=segments_1t,generation=65}
[junit4] 1> 303428 [qtp354082693-180] INFO org.apache.solr.core.SolrCore – newest commit generation = 65
[junit4] 1> 303435 [qtp354082693-180] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@55e3dc28 main
[junit4] 1> 303438 [qtp354082693-180] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4] 1> 303439 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@55e3dc28 main{StandardDirectoryReader(segments_1t:177:nrt _1k(5.0):C9)}
[junit4] 1> 303439 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4] 1> 303443 [searcherExecutor-65-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@55e3dc28 main{StandardDirectoryReader(segments_1t:177:nrt _1k(5.0):C9)}
[junit4] 1> 303446 [qtp354082693-180] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 25
[junit4] 1> 303452 [qtp354082693-176] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=javabin&version=2&rows=9} hits=9 status=0 QTime=1
[junit4] 1> 303455 [TEST-SolrExampleStreamingBinaryTest.testUnicode-seed#[C680F8F72705BF0A]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testUnicode
[junit4] 1> 303475 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CoreContainer – Shutting down CoreContainer instance=430251425
[junit4] 1> 303476 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.SolrCore – [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4b60a20f
[junit4] 1> 303547 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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=0,errors=1,cumulative_adds=145,cumulative_deletesById=5,cumulative_deletesByQuery=27,cumulative_errors=1}
[junit4] 1> 303549 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.update.SolrCoreState – Closing SolrCoreState
[junit4] 1> 303549 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.update.DefaultSolrCoreState – SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 1> 303549 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.update.DefaultSolrCoreState – closing IndexWriter with IndexWriterCloser
[junit4] 1> 303554 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.SolrCore – [collection1] Closing main searcher on request.
[junit4] 1> 303554 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 1> 303555 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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-SolrExampleStreamingBinaryTest-1374354270878\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1374354270878\index;done=false>>]
[junit4] 1> 303555 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1374354270878\index
[junit4] 1> 303556 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-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-SolrExampleStreamingBinaryTest-1374354270878\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1374354270878\;done=false>>]
[junit4] 1> 303556 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-solrj\test\J0\solrtest-SolrExampleStreamingBinaryTest-1374354270878\
[junit4] 1> 303557 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.eclipse.jetty.server.handler.ContextHandler – stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 1> 303612 [SUITE-SolrExampleStreamingBinaryTest-seed#[C680F8F72705BF0A]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=de_AT, timezone=America/Montreal
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_25 (64-bit)/cpus=2,threads=11,free=30865408,total=64024576
[junit4] 2> NOTE: All tests run in this JVM: [SolrExampleStreamingTest, ContentStreamTest, CloudSolrServerTest, ClientUtilsTest, SolrExampleStreamingBinaryTest]
[junit4] Completed in 220.76s, 27 tests, 1 error <<< FAILURES!
[...truncated 131 lines...]
BUILD FAILED
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:389: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:369: 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:449: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1247: The following error occurred while executing this line:
C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:890: There were test failures: 46 suites, 272 tests, 1 error, 1 ignored (1 assumption)
Total time: 80 minutes 25 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_25 -XX:+UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure