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/05/31 23:16:58 UTC
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.7.0_21) - Build #
5922 - Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/5922/
Java: 64bit/jdk1.7.0_21 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed.
REGRESSION: org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest.testWaitOptions
Error Message:
IOException occured when talking to server at: https://127.0.0.1:42206/solr/collection1
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:42206/solr/collection1
at __randomizedtesting.SeedInfo.seed([C7CC5ABF653B6F33:818DD704463D21D0]: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.embedded.SolrExampleStreamingTest.testWaitOptions(SolrExampleStreamingTest.java:103)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:601)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
at java.lang.Thread.run(Thread.java:722)
Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
... 46 more
Build Log:
[...truncated 10574 lines...]
[junit4:junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest
[junit4:junit4] 1> 0 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.SolrJettyTestBase – Randomized ssl (true) and clientAuth (false)
[junit4:junit4] 1> 7 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ####initCore
[junit4:junit4] 1> 9 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ####initCore end
[junit4:junit4] 1> 166 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.eclipse.jetty.server.Server – jetty-8.1.10.v20130312
[junit4:junit4] 1> 533 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.eclipse.jetty.util.ssl.SslContextFactory – Enabled Protocols [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2] of [SSLv2Hello, SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4:junit4] 1> 578 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.eclipse.jetty.server.AbstractConnector – Started SslSelectChannelConnector@127.0.0.1:42206
[junit4:junit4] 1> 615 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – SolrDispatchFilter.init()
[junit4:junit4] 1> 664 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrResourceLoader – JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 1> 666 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrResourceLoader – using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr
[junit4:junit4] 1> 711 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CoreContainer – looking for solr config file: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/solr.xml
[junit4:junit4] 1> 720 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CoreContainer – New CoreContainer 358529815
[junit4:junit4] 1> 721 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CoreContainer – Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/'
[junit4:junit4] 1> 722 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrResourceLoader – new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/'
[junit4:junit4] 1> 1022 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr
[junit4:junit4] 1> 1024 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Discovered properties file /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/core.properties, adding to cores
[junit4:junit4] 1> 1027 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn
[junit4:junit4] 1> 1030 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/prop-base
[junit4:junit4] 1> 1032 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/tmp
[junit4:junit4] 1> 1033 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/tmp/prop-base
[junit4:junit4] 1> 1034 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/tmp/text-base
[junit4:junit4] 1> 1035 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/tmp/props
[junit4:junit4] 1> 1037 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/text-base
[junit4:junit4] 1> 1038 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCoreDiscoverer – Looking for cores in /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/.svn/props
[junit4:junit4] 1> 1048 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting socketTimeout to: 0
[junit4:junit4] 1> 1049 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting urlScheme to: http://
[junit4:junit4] 1> 1050 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting connTimeout to: 0
[junit4:junit4] 1> 1051 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maxConnectionsPerHost to: 20
[junit4:junit4] 1> 1051 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting corePoolSize to: 0
[junit4:junit4] 1> 1052 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maximumPoolSize to: 2147483647
[junit4:junit4] 1> 1053 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting maxThreadIdleTime to: 5
[junit4:junit4] 1> 1053 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting sizeOfQueue to: -1
[junit4:junit4] 1> 1054 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.handler.component.HttpShardHandlerFactory – Setting fairnessPolicy to: false
[junit4:junit4] 1> 1068 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4] 1> 1151 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.logging.LogWatcher – Registering Log Listener
[junit4:junit4] 1> 1181 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.CoreContainer – Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1
[junit4:junit4] 1> 1182 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrResourceLoader – new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/'
[junit4:junit4] 1> 1278 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrConfig – Adding specified lib dirs to ClassLoader
[junit4:junit4] 1> 1280 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – No files added to classloader from lib: ../../../contrib/extraction/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../contrib/extraction/lib).
[junit4:junit4] 1> 1281 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../dist).
[junit4:junit4] 1> 1282 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – No files added to classloader from lib: ../../../contrib/clustering/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../contrib/clustering/lib).
[junit4:junit4] 1> 1282 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../dist).
[junit4:junit4] 1> 1283 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – No files added to classloader from lib: ../../../contrib/langid/lib/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../contrib/langid/lib).
[junit4:junit4] 1> 1284 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../dist).
[junit4:junit4] 1> 1285 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – No files added to classloader from lib: ../../../contrib/velocity/lib (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../contrib/velocity/lib).
[junit4:junit4] 1> 1285 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/../../../dist).
[junit4:junit4] 1> 1286 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrResourceLoader – Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4:junit4] 1> 1427 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrConfig – Using Lucene MatchVersion: LUCENE_50
[junit4:junit4] 1> 1558 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.Config – Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 1> 1568 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.schema.IndexSchema – Reading Solr Schema from schema.xml
[junit4:junit4] 1> 1625 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.schema.IndexSchema – [collection1] Schema name=example
[junit4:junit4] 1> 2601 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.schema.IndexSchema – unique key field: id
[junit4:junit4] 1> 2767 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider – Reloading exchange rates from file currency.xml
[junit4:junit4] 1> 2778 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.schema.FileExchangeRateProvider – Reloading exchange rates from file currency.xml
[junit4:junit4] 1> 2971 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 1> 2979 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/
[junit4:junit4] 1> 2981 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.JmxMonitoredMap – JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@3dc572d0
[junit4:junit4] 1> 3046 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4] 1> 3046 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4:junit4] 1> 3054 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 1> 3092 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.CachingDirectoryFactory – return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660
[junit4:junit4] 1> 3093 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index/
[junit4:junit4] 1> 3093 [coreLoadExecutor-3-thread-1] WARN org.apache.solr.core.SolrCore – [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index' doesn't exist. Creating new index...
[junit4:junit4] 1> 3104 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.CachingDirectoryFactory – return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index
[junit4:junit4] 1> 3191 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=1
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1,generation=1}
[junit4:junit4] 1> 3192 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – newest commit generation = 1
[junit4:junit4] 1> 3199 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – created json: solr.JSONResponseWriter
[junit4:junit4] 1> 3200 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4:junit4] 1> 3201 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – created velocity: solr.VelocityResponseWriter
[junit4:junit4] 1> 3209 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – created xslt: solr.XSLTResponseWriter
[junit4:junit4] 1> 3209 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.response.XSLTResponseWriter – xsltCacheLifetimeSeconds=5
[junit4:junit4] 1> 3472 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /select: solr.SearchHandler
[junit4:junit4] 1> 3474 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /query: solr.SearchHandler
[junit4:junit4] 1> 3479 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /get: solr.RealTimeGetHandler
[junit4:junit4] 1> 3480 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /browse: solr.SearchHandler
[junit4:junit4] 1> 3488 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update: solr.UpdateRequestHandler
[junit4:junit4] 1> 3493 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/json: solr.JsonUpdateRequestHandler
[junit4:junit4] 1> 3498 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/csv: solr.CSVRequestHandler
[junit4:junit4] 1> 3498 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 1> 3500 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 1> 3500 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4:junit4] 1> 3501 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4:junit4] 1> 3501 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 1> 3502 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 1> 3507 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /admin/: solr.admin.AdminHandlers
[junit4:junit4] 1> 3512 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /admin/ping: solr.PingRequestHandler
[junit4:junit4] 1> 3517 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 1> 3530 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /replication: solr.ReplicationHandler
[junit4:junit4] 1> 3531 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 3532 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /spell: solr.SearchHandler
[junit4:junit4] 1> 3532 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 3533 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /tvrh: solr.SearchHandler
[junit4:junit4] 1> 3534 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 3535 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /terms: solr.SearchHandler
[junit4:junit4] 1> 3535 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 1> 3536 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.RequestHandlers – created /elevate: solr.SearchHandler
[junit4:junit4] 1> 3564 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 3569 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 3571 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.loader.XMLLoader – xsltCacheLifetimeSeconds=60
[junit4:junit4] 1> 3587 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@15e7ae59 main
[junit4:junit4] 1> 3607 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.update.UpdateHandler – Clearing tlog files, tlogDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/tlog
[junit4:junit4] 1> 3615 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – Hard AutoCommit: if uncommited for 15000ms;
[junit4:junit4] 1> 3616 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.SolrCore – Soft AutoCommit: disabled
[junit4:junit4] 1> 3618 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Initializing spell checkers
[junit4:junit4] 1> 3633 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.spelling.DirectSolrSpellChecker – init: {name=default,field=text,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4:junit4] 1> 3648 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – No queryConverter defined, using default converter
[junit4:junit4] 1> 3653 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.component.QueryElevationComponent – Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/example/solr/collection1/conf/elevate.xml
[junit4:junit4] 1> 3725 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.handler.ReplicationHandler – Commits will be reserved for 10000
[junit4:junit4] 1> 3726 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@15e7ae59 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 1> 3832 [searcherExecutor-4-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=102
[junit4:junit4] 1> 3833 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 3834 [searcherExecutor-4-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Loading spell index for spellchecker: default
[junit4:junit4] 1> 3835 [searcherExecutor-4-thread-1] INFO org.apache.solr.handler.component.SpellCheckComponent – Loading spell index for spellchecker: wordbreak
[junit4:junit4] 1> 3840 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@15e7ae59 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 1> 3850 [coreLoadExecutor-3-thread-1] INFO org.apache.solr.core.CoreContainer – registering core: collection1
[junit4:junit4] 1> 3854 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1
[junit4:junit4] 1> 3855 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.servlet.SolrDispatchFilter – SolrDispatchFilter.init() done
[junit4:junit4] 1> 3857 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.SolrJettyTestBase – Jetty Assigned Port#42206
[junit4:junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/./solrtest-SolrExampleStreamingTest-1370034783660
[junit4:junit4] 1> 3893 [TEST-SolrExampleStreamingTest.testPingHandler-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testPingHandler
[junit4:junit4] 1> 3914 [TEST-SolrExampleStreamingTest.testPingHandler-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 1> 4595 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onInit: commits: num=1
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1,generation=1}
[junit4:junit4] 1> 4600 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – newest commit generation = 1
[junit4:junit4] 1> 4623 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4688cb58 realtime
[junit4:junit4] 1> 4627 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585598107254784)} 0 123
[junit4:junit4] 1> 4675 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 4678 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1,generation=1}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_2,generation=2}
[junit4:junit4] 1> 4679 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 2
[junit4:junit4] 1> 4681 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@77f2df26 main
[junit4:junit4] 1> 4684 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@77f2df26 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4] 1> 4685 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 4684 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 4695 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@77f2df26 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4] 1> 4698 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 23
[junit4:junit4] 1> 4715 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=2
[junit4:junit4] 1> 4728 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/admin/ping params={wt=xml&version=2.2} hits=0 status=0 QTime=3
[junit4:junit4] 1> 4729 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/admin/ping params={wt=xml&version=2.2} status=0 QTime=4
[junit4:junit4] 1> 4733 [TEST-SolrExampleStreamingTest.testPingHandler-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testPingHandler
[junit4:junit4] 1> 4759 [TEST-SolrExampleStreamingTest.testStatistics-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testStatistics
[junit4:junit4] 1> 4764 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585598297047040)} 0 1
[junit4:junit4] 1> 4771 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 4773 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_2,generation=2}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_3,generation=3}
[junit4:junit4] 1> 4774 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 3
[junit4:junit4] 1> 4775 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@79c1438 main
[junit4:junit4] 1> 4776 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@79c1438 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4] 1> 4777 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 4776 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 4788 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@79c1438 main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4:junit4] 1> 4790 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 19
[junit4:junit4] 1> 4797 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 4803 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@37023619
[junit4:junit4] 1> 4804 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6bce2c0c
[junit4:junit4] 1> 4804 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@b185a44
[junit4:junit4] 1> 4803 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4af3011a
[junit4:junit4] 1> 4803 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@52a83f35
[junit4:junit4] 1> 5070 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc0 (1436585598374641664), doc5 (1436585598426021888), doc6 (1436585598427070464), doc7 (1436585598428119040), doc8 (1436585598429167616), doc9 (1436585598429167617)]} 0 239
[junit4:junit4] 1> 5072 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc0 is 200
[junit4:junit4] 1> 5073 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@37023619
[junit4:junit4] 1> 5088 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc1 (1436585598377787392)]} 0 249
[junit4:junit4] 1> 5090 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc1 is 200
[junit4:junit4] 1> 5090 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc4 (1436585598381981697)]} 0 246
[junit4:junit4] 1> 5092 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6bce2c0c
[junit4:junit4] 1> 5093 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc4 is 200
[junit4:junit4] 1> 5091 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc2 (1436585598381981696)]} 0 248
[junit4:junit4] 1> 5094 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@52a83f35
[junit4:junit4] 1> 5096 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc3 (1436585598385127424)]} 0 250
[junit4:junit4] 1> 5096 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc2 is 200
[junit4:junit4] 1> 5097 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc3 is 200
[junit4:junit4] 1> 5098 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@b185a44
[junit4:junit4] 1> 5098 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4af3011a
[junit4:junit4] 1> 5103 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 5222 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_3,generation=3}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_4,generation=4}
[junit4:junit4] 1> 5222 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 4
[junit4:junit4] 1> 5258 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@24cb4888 main
[junit4:junit4] 1> 5259 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 5259 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@24cb4888 main{StandardDirectoryReader(segments_4:9:nrt _1(5.0):C2 _0(5.0):C6 _2(5.0):C1 _3(5.0):C1)}
[junit4:junit4] 1> 5261 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 5273 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@24cb4888 main{StandardDirectoryReader(segments_4:9:nrt _1(5.0):C2 _0(5.0):C6 _2(5.0):C1 _3(5.0):C1)}
[junit4:junit4] 1> 5275 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 172
[junit4:junit4] 1> 5297 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=10 status=0 QTime=15
[junit4:junit4] 1> 5367 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=xml&version=2.2&rows=0} hits=10 status=0 QTime=35
[junit4:junit4] 1> 5410 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@1f686b6 realtime
[junit4:junit4] 1> 5411 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585598946115584)} 0 29
[junit4:junit4] 1> 5418 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 5420 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_4,generation=4}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_5,generation=5}
[junit4:junit4] 1> 5421 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 5
[junit4:junit4] 1> 5427 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@21d90526 main
[junit4:junit4] 1> 5429 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@21d90526 main{StandardDirectoryReader(segments_4:11:nrt)}
[junit4:junit4] 1> 5430 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 5429 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 5440 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@21d90526 main{StandardDirectoryReader(segments_4:11:nrt)}
[junit4:junit4] 1> 5444 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 27
[junit4:junit4] 1> 5450 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 5454 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1bbb5095
[junit4:junit4] 1> 5454 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3bcc7247
[junit4:junit4] 1> 5454 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1c934e78
[junit4:junit4] 1> 5454 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b62b1fc
[junit4:junit4] 1> 5454 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@26a7746c
[junit4:junit4] 1> 5458 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b62b1fc
[junit4:junit4] 1> 5458 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@26a7746c
[junit4:junit4] 1> 5710 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc10 (1436585599028953088), doc13 (1436585599031050240), doc14 (1436585599032098816)]} 0 249
[junit4:junit4] 1> 5711 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc11 (1436585599030001664)]} 0 250
[junit4:junit4] 1> 5711 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc12 (1436585599028953089)]} 0 250
[junit4:junit4] 1> 5712 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc10 is 200
[junit4:junit4] 1> 5713 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc11 is 200
[junit4:junit4] 1> 5714 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1bbb5095
[junit4:junit4] 1> 5713 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc12 is 200
[junit4:junit4] 1> 5715 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3bcc7247
[junit4:junit4] 1> 5717 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1c934e78
[junit4:junit4] 1> 5723 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 5751 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_5,generation=5}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_6,generation=6}
[junit4:junit4] 1> 5752 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 6
[junit4:junit4] 1> 5758 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@1f3e29be main
[junit4:junit4] 1> 5759 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 5759 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@1f3e29be main{StandardDirectoryReader(segments_6:17:nrt _5(5.0):C3 _4(5.0):C1 _6(5.0):C1)}
[junit4:junit4] 1> 5761 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 5773 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@1f3e29be main{StandardDirectoryReader(segments_6:17:nrt _5(5.0):C3 _4(5.0):C1 _6(5.0):C1)}
[junit4:junit4] 1> 5775 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 52
[junit4:junit4] 1> 5782 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=5 status=0 QTime=1
[junit4:junit4] 1> 5795 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={stats.field=val_pi&stats=true&q=*:*&wt=xml&version=2.2&rows=0} hits=5 status=0 QTime=1
[junit4:junit4] 1> 5806 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@732d0fda realtime
[junit4:junit4] 1> 5807 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585599386517504)} 0 5
[junit4:junit4] 1> 5813 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 5816 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_6,generation=6}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_7,generation=7}
[junit4:junit4] 1> 5816 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 7
[junit4:junit4] 1> 5818 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@614d8f7f main
[junit4:junit4] 1> 5819 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@614d8f7f main{StandardDirectoryReader(segments_6:19:nrt)}
[junit4:junit4] 1> 5820 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 5820 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 5826 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@614d8f7f main{StandardDirectoryReader(segments_6:19:nrt)}
[junit4:junit4] 1> 5830 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4] 1> 5836 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 5840 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4be0ef40
[junit4:junit4] 1> 5840 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6e70d828
[junit4:junit4] 1> 5840 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1c7b79ab
[junit4:junit4] 1> 5840 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@492b8031
[junit4:junit4] 1> 5840 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@327f62bd
[junit4:junit4] 1> 6097 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc1 (1436585599437897729), doc7 (1436585599444189185)]} 0 247
[junit4:junit4] 1> 6098 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc9 (1436585599438946304)]} 0 248
[junit4:junit4] 1> 6098 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc0 (1436585599437897728), doc3 (1436585599444189184), doc5 (1436585599447334912), doc6 (1436585599450480640), doc8 (1436585599453626368)]} 0 248
[junit4:junit4] 1> 6098 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc2 (1436585599436849152)]} 0 250
[junit4:junit4] 1> 6103 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc0 is 200
[junit4:junit4] 1> 6101 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc9 is 200
[junit4:junit4] 1> 6101 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[doc4 (1436585599439994880)]} 0 249
[junit4:junit4] 1> 6100 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc1 is 200
[junit4:junit4] 1> 6106 [concurrentUpdateScheduler-1-thread-3] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@327f62bd
[junit4:junit4] 1> 6108 [concurrentUpdateScheduler-1-thread-4] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6e70d828
[junit4:junit4] 1> 6105 [concurrentUpdateScheduler-1-thread-2] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@4be0ef40
[junit4:junit4] 1> 6105 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc2 is 200
[junit4:junit4] 1> 6107 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: doc4 is 200
[junit4:junit4] 1> 6112 [concurrentUpdateScheduler-1-thread-5] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1c7b79ab
[junit4:junit4] 1> 6113 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@492b8031
[junit4:junit4] 1> 6119 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 6156 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_7,generation=7}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_8,generation=8}
[junit4:junit4] 1> 6158 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 8
[junit4:junit4] 1> 6164 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@66d7e31d main
[junit4:junit4] 1> 6166 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 6166 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@66d7e31d main{StandardDirectoryReader(segments_8:27:nrt _8(5.0):C3 _9(5.0):C5 _a(5.0):C1 _7(5.0):C1)}
[junit4:junit4] 1> 6168 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 6177 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@66d7e31d main{StandardDirectoryReader(segments_8:27:nrt _8(5.0):C3 _9(5.0):C5 _a(5.0):C1 _7(5.0):C1)}
[junit4:junit4] 1> 6179 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 60
[junit4:junit4] 1> 6192 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=inStock:true&wt=xml&version=2.2} hits=5 status=0 QTime=6
[junit4:junit4] 1> 6205 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=inStock:false&wt=xml&version=2.2} hits=5 status=0 QTime=1
[junit4:junit4] 1> 6238 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={f.val_pi.stats.facet=inStock&stats.field=val_pi&stats=true&q=*:*&wt=xml&version=2.2&rows=0} hits=10 status=0 QTime=19
[junit4:junit4] 1> 6243 [TEST-SolrExampleStreamingTest.testStatistics-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testStatistics
[junit4:junit4] 1> 6277 [TEST-SolrExampleStreamingTest.testCommitWithinOnDelete-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testCommitWithinOnDelete
[junit4:junit4] 1> 6285 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7703f0d2 realtime
[junit4:junit4] 1> 6287 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585599888785408)} 0 7
[junit4:junit4] 1> 6293 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 6295 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_8,generation=8}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_9,generation=9}
[junit4:junit4] 1> 6297 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 9
[junit4:junit4] 1> 6301 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@60c0bab6 main
[junit4:junit4] 1> 6302 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@60c0bab6 main{StandardDirectoryReader(segments_8:29:nrt)}
[junit4:junit4] 1> 6303 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 6302 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 6310 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@60c0bab6 main{StandardDirectoryReader(segments_8:29:nrt)}
[junit4:junit4] 1> 6316 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 23
[junit4:junit4] 1> 6322 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 6331 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@65926afe
[junit4:junit4] 1> 6586 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id3 (1436585599947505664)]} 0 250
[junit4:junit4] 1> 6589 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id3 is 200
[junit4:junit4] 1> 6590 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@65926afe
[junit4:junit4] 1> 6596 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 6606 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_9,generation=9}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_a,generation=10}
[junit4:junit4] 1> 6608 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 10
[junit4:junit4] 1> 6612 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@fca3b91 main
[junit4:junit4] 1> 6614 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@fca3b91 main{StandardDirectoryReader(segments_a:31:nrt _b(5.0):C1)}
[junit4:junit4] 1> 6615 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 6614 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 6624 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@fca3b91 main{StandardDirectoryReader(segments_a:31:nrt _b(5.0):C1)}
[junit4:junit4] 1> 6626 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 30
[junit4:junit4] 1> 6636 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=2
[junit4:junit4] 1> 6647 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {delete=[id3 (-1436585600271515648)]} 0 2
[junit4:junit4] 1> 6656 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=0
[junit4:junit4] 1> 6915 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=0
[junit4:junit4] 1> 7174 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 7433 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=0
[junit4:junit4] 1> 7647 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 1> 7649 [commitScheduler-7-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@573560a0 main
[junit4:junit4] 1> 7649 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 7650 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@573560a0 main{StandardDirectoryReader(segments_a:33:nrt)}
[junit4:junit4] 1> 7651 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 7655 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@573560a0 main{StandardDirectoryReader(segments_a:33:nrt)}
[junit4:junit4] 1> 7692 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 7694 [TEST-SolrExampleStreamingTest.testCommitWithinOnDelete-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testCommitWithinOnDelete
[junit4:junit4] 1> 7712 [TEST-SolrExampleStreamingTest.testUpdateField-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testUpdateField
[junit4:junit4] 1> 7716 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585601392443392)} 0 1
[junit4:junit4] 1> 7722 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 7723 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_a,generation=10}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_b,generation=11}
[junit4:junit4] 1> 7724 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 11
[junit4:junit4] 1> 7725 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@33c61cf2 main
[junit4:junit4] 1> 7725 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 7725 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@33c61cf2 main{StandardDirectoryReader(segments_a:33:nrt)}
[junit4:junit4] 1> 7727 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 7733 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@33c61cf2 main{StandardDirectoryReader(segments_a:33:nrt)}
[junit4:junit4] 1> 7735 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 13
[junit4:junit4] 1> 7738 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2ab517e2
[junit4:junit4] 1> 7992 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1436585601420754944)]} 0 250
[junit4:junit4] 1> 7994 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: unique is 200
[junit4:junit4] 1> 7995 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2ab517e2
[junit4:junit4] 1> 7999 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8008 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_b,generation=11}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_c,generation=12}
[junit4:junit4] 1> 8009 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 12
[junit4:junit4] 1> 8011 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4ce494be main
[junit4:junit4] 1> 8012 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@4ce494be main{StandardDirectoryReader(segments_c:35:nrt _c(5.0):C1)}
[junit4:junit4] 1> 8013 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 8012 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 8019 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@4ce494be main{StandardDirectoryReader(segments_c:35:nrt _c(5.0):C1)}
[junit4:junit4] 1> 8021 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 22
[junit4:junit4] 1> 8030 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=5
[junit4:junit4] 1> 8033 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@79cf5c86
[junit4:junit4] 1> 8037 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 1
[junit4:junit4] 1> 8286 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: unique is 409
[junit4:junit4] 1> 8287 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@79cf5c86
[junit4:junit4] 1> 8291 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8294 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_c,generation=12}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_d,generation=13}
[junit4:junit4] 1> 8295 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 13
[junit4:junit4] 1> 8296 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@6283ca19 main
[junit4:junit4] 1> 8298 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 8298 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@6283ca19 main{StandardDirectoryReader(segments_c:35:nrt _c(5.0):C1)}
[junit4:junit4] 1> 8300 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 8304 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@6283ca19 main{StandardDirectoryReader(segments_c:35:nrt _c(5.0):C1)}
[junit4:junit4] 1> 8305 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 14
[junit4:junit4] 1> 8308 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@11f46366
[junit4:junit4] 1> 8561 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1436585602018443264)]} 0 250
[junit4:junit4] 1> 8562 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: unique is 200
[junit4:junit4] 1> 8563 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@11f46366
[junit4:junit4] 1> 8568 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8576 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_d,generation=13}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_e,generation=14}
[junit4:junit4] 1> 8577 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 14
[junit4:junit4] 1> 8580 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7018327d main
[junit4:junit4] 1> 8581 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@7018327d main{StandardDirectoryReader(segments_e:39:nrt _d(5.0):C1)}
[junit4:junit4] 1> 8582 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 8582 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 8588 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@7018327d main{StandardDirectoryReader(segments_e:39:nrt _d(5.0):C1)}
[junit4:junit4] 1> 8590 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 22
[junit4:junit4] 1> 8596 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 8599 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7e6662f6
[junit4:junit4] 1> 8852 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[unique (1436585602323578880)]} 0 250
[junit4:junit4] 1> 8854 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: unique is 200
[junit4:junit4] 1> 8855 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7e6662f6
[junit4:junit4] 1> 8858 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8863 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_e,generation=14}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_f,generation=15}
[junit4:junit4] 1> 8864 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 15
[junit4:junit4] 1> 8869 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@35f76d07 main
[junit4:junit4] 1> 8871 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@35f76d07 main{StandardDirectoryReader(segments_f:43:nrt _e(5.0):C1)}
[junit4:junit4] 1> 8872 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 8872 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 8878 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@35f76d07 main{StandardDirectoryReader(segments_f:43:nrt _e(5.0):C1)}
[junit4:junit4] 1> 8880 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 22
[junit4:junit4] 1> 8885 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={fl=id,price_f,name,_version_&q=*:*&wt=xml&version=2.2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 8888 [TEST-SolrExampleStreamingTest.testUpdateField-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testUpdateField
[junit4:junit4] 1> 8905 [TEST-SolrExampleStreamingTest.testContentStreamRequest-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testContentStreamRequest
[junit4:junit4] 1> 8911 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@76d0312a realtime
[junit4:junit4] 1> 8912 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585602645491712)} 0 2
[junit4:junit4] 1> 8917 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8919 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_f,generation=15}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_g,generation=16}
[junit4:junit4] 1> 8920 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – newest commit generation = 16
[junit4:junit4] 1> 8923 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3da66cdb main
[junit4:junit4] 1> 8926 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3da66cdb main{StandardDirectoryReader(segments_f:45:nrt)}
[junit4:junit4] 1> 8927 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 8926 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 8933 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3da66cdb main{StandardDirectoryReader(segments_f:45:nrt)}
[junit4:junit4] 1> 8935 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 18
[junit4:junit4] 1> 8940 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 8980 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 8994 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_g,generation=16}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_h,generation=17}
[junit4:junit4] 1> 8995 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 17
[junit4:junit4] 1> 8999 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@2b8af779 main
[junit4:junit4] 1> 9000 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@2b8af779 main{StandardDirectoryReader(segments_h:47:nrt _f(5.0):C10)}
[junit4:junit4] 1> 9001 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 9000 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 9007 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@2b8af779 main{StandardDirectoryReader(segments_h:47:nrt _f(5.0):C10)}
[junit4:junit4] 1> 9009 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {add=[0553573403 (1436585602698969088), 0553579908 (1436585602702114816), 055357342X (1436585602704211968), 0553293354 (1436585602706309120), 0812521390 (1436585602707357696), 0812550706 (1436585602709454848), 0441385532 (1436585602711552000), 0380014300 (1436585602713649152), 0805080481 (1436585602715746304), 080508049X (1436585602716794880)],commit=} 0 60
[junit4:junit4] 1> 9014 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=10 status=0 QTime=1
[junit4:junit4] 1> 9027 [TEST-SolrExampleStreamingTest.testContentStreamRequest-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testContentStreamRequest
[junit4:junit4] 1> 9044 [TEST-SolrExampleStreamingTest.testAugmentFields-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testAugmentFields
[junit4:junit4] 1> 9050 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@42096939 realtime
[junit4:junit4] 1> 9051 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585602790195200)} 0 3
[junit4:junit4] 1> 9053 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@77db3f0d
[junit4:junit4] 1> 9307 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[111 (1436585602798583808)]} 0 251
[junit4:junit4] 1> 9310 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 111 is 200
[junit4:junit4] 1> 9312 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@77db3f0d
[junit4:junit4] 1> 9317 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 9326 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_h,generation=17}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_i,generation=18}
[junit4:junit4] 1> 9327 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 18
[junit4:junit4] 1> 9331 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7eb8f64 main
[junit4:junit4] 1> 9334 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@7eb8f64 main{StandardDirectoryReader(segments_i:51:nrt _g(5.0):C1)}
[junit4:junit4] 1> 9335 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 9334 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 9343 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@7eb8f64 main{StandardDirectoryReader(segments_i:51:nrt _g(5.0):C1)}
[junit4:junit4] 1> 9345 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 28
[junit4:junit4] 1> 9349 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@17bc4c8
[junit4:junit4] 1> 9604 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[222 (1436585603111059456)]} 0 250
[junit4:junit4] 1> 9606 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 222 is 200
[junit4:junit4] 1> 9608 [concurrentUpdateScheduler-1-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@17bc4c8
[junit4:junit4] 1> 9614 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 9626 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_i,generation=18}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_j,generation=19}
[junit4:junit4] 1> 9627 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 19
[junit4:junit4] 1> 9631 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@28365965 main
[junit4:junit4] 1> 9634 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@28365965 main{StandardDirectoryReader(segments_j:53:nrt _g(5.0):C1 _h(5.0):C1)}
[junit4:junit4] 1> 9634 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 9635 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 9643 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@28365965 main{StandardDirectoryReader(segments_j:53:nrt _g(5.0):C1 _h(5.0):C1)}
[junit4:junit4] 1> 9645 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 31
[junit4:junit4] 1> 9701 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={sort=price+asc&fl=id,price,[docid],[explain+style%3Dnl],score,aaa:[value+v%3Daaa],ten:[value+v%3D10+t%3Dint]&q=*:*&wt=xml&version=2.2} hits=2 status=0 QTime=46
[junit4:junit4] 1> 9705 [TEST-SolrExampleStreamingTest.testAugmentFields-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testAugmentFields
[junit4:junit4] 1> 9720 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testWaitOptions
[junit4:junit4] 1> 9720 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.HttpClientUtil – Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 1> 9724 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – blocking for commit/optimize
[junit4:junit4] 1> 9800 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 9808 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_j,generation=19}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_k,generation=20}
[junit4:junit4] 1> 9809 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 20
[junit4:junit4] 1> 9812 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@74396fd4 main
[junit4:junit4] 1> 9814 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@74396fd4 main{StandardDirectoryReader(segments_k:55:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1)}
[junit4:junit4] 1> 9814 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 9815 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 9824 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@74396fd4 main{StandardDirectoryReader(segments_k:55:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1)}
[junit4:junit4] 1> 9826 [qtp2047162682-18] 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 (1436585603576627200)],commit=} 0 28
[junit4:junit4] 1> 9833 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – blocking for commit/optimize
[junit4:junit4] 1> 9833 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5948f683
[junit4:junit4] 1> 9845 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 9852 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_k,generation=20}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_l,generation=21}
[junit4:junit4] 1> 9853 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – newest commit generation = 21
[junit4:junit4] 1> 9857 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@54f9c0d0 main
[junit4:junit4] 1> 9858 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@54f9c0d0 main{StandardDirectoryReader(segments_l:57:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1)}
[junit4:junit4] 1> 9858 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 9859 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 9868 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@54f9c0d0 main{StandardDirectoryReader(segments_l:57:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1)}
[junit4:junit4] 1> 10092 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10093 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_l,generation=21}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_m,generation=22}
[junit4:junit4] 1> 10094 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – newest commit generation = 22
[junit4:junit4] 1> 10095 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@400cbebc main
[junit4:junit4] 1> 10095 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10095 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@400cbebc main{StandardDirectoryReader(segments_l:57:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1)}
[junit4:junit4] 1> 10096 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10096 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=false&commit=true&wt=javabin&version=2&softCommit=false} {add=[43 (1436585603623813120)],commit=,commit=} 0 253
[junit4:junit4] 1> 10098 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 43 is 200
[junit4:junit4] 1> 10099 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5948f683
[junit4:junit4] 1> 10100 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@400cbebc main{StandardDirectoryReader(segments_l:57:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1)}
[junit4:junit4] 1> 10106 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10116 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_m,generation=22}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_n,generation=23}
[junit4:junit4] 1> 10117 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 23
[junit4:junit4] 1> 10120 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@2d07eef3 main
[junit4:junit4] 1> 10126 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@2d07eef3 main{StandardDirectoryReader(segments_n:59:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1)}
[junit4:junit4] 1> 10127 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10126 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10131 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@2d07eef3 main{StandardDirectoryReader(segments_n:59:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1)}
[junit4:junit4] 1> 10132 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {add=[44 (1436585603897491456)],commit=} 0 29
[junit4:junit4] 1> 10134 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5de1beea
[junit4:junit4] 1> 10134 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – blocking for commit/optimize
[junit4:junit4] 1> 10141 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10149 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_n,generation=23}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_o,generation=24}
[junit4:junit4] 1> 10150 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 24
[junit4:junit4] 1> 10153 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4e89e3c6 main
[junit4:junit4] 1> 10155 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@4e89e3c6 main{StandardDirectoryReader(segments_o:61:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1 _l(5.0):C1)}
[junit4:junit4] 1> 10155 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10155 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10159 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@4e89e3c6 main{StandardDirectoryReader(segments_o:61:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1 _l(5.0):C1)}
[junit4:junit4] 1> 10388 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10390 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_o,generation=24}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_p,generation=25}
[junit4:junit4] 1> 10391 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 25
[junit4:junit4] 1> 10392 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@64503824 main
[junit4:junit4] 1> 10393 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10393 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@64503824 main{StandardDirectoryReader(segments_o:61:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1 _l(5.0):C1)}
[junit4:junit4] 1> 10393 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10393 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=false&commit=true&wt=javabin&version=2&softCommit=false} {add=[45 (1436585603934191616)],commit=,commit=} 0 254
[junit4:junit4] 1> 10395 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 45 is 200
[junit4:junit4] 1> 10396 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@5de1beea
[junit4:junit4] 1> 10399 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@64503824 main{StandardDirectoryReader(segments_o:61:nrt _g(5.0):C1 _h(5.0):C1 _i(5.0):C1 _j(5.0):C1 _k(5.0):C1 _l(5.0):C1)}
[junit4:junit4] 1> 10401 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10436 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_p,generation=25}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_q,generation=26}
[junit4:junit4] 1> 10437 [qtp2047162682-17] INFO org.apache.solr.core.SolrCore – newest commit generation = 26
[junit4:junit4] 1> 10440 [qtp2047162682-17] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@200ccb9d main
[junit4:junit4] 1> 10442 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@200ccb9d main{StandardDirectoryReader(segments_q:65:nrt _n(5.0):C7)}
[junit4:junit4] 1> 10442 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10442 [qtp2047162682-17] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10445 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@200ccb9d main{StandardDirectoryReader(segments_q:65:nrt _n(5.0):C7)}
[junit4:junit4] 1> 10497 [qtp2047162682-17] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {add=[46 (1436585604207869952)],optimize=} 0 97
[junit4:junit4] 1> 10499 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – blocking for commit/optimize
[junit4:junit4] 1> 10499 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@280bc0db
[junit4:junit4] 1> 10504 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10514 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_q,generation=26}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_r,generation=27}
[junit4:junit4] 1> 10515 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 27
[junit4:junit4] 1> 10517 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@29d45f47 main
[junit4:junit4] 1> 10518 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@29d45f47 main{StandardDirectoryReader(segments_r:69:nrt _p(5.0):C8)}
[junit4:junit4] 1> 10518 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10518 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10522 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@29d45f47 main{StandardDirectoryReader(segments_r:69:nrt _p(5.0):C8)}
[junit4:junit4] 1> 10753 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10754 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_r,generation=27}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_s,generation=28}
[junit4:junit4] 1> 10755 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 28
[junit4:junit4] 1> 10756 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@57b15b1a main
[junit4:junit4] 1> 10756 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10756 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@57b15b1a main{StandardDirectoryReader(segments_r:69:nrt _p(5.0):C8)}
[junit4:junit4] 1> 10757 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10757 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=false&maxSegments=1&wt=javabin&version=2} {add=[47 (1436585604315873280)],optimize=,optimize=} 0 254
[junit4:junit4] 1> 10759 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 47 is 200
[junit4:junit4] 1> 10760 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@280bc0db
[junit4:junit4] 1> 10762 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@57b15b1a main{StandardDirectoryReader(segments_r:69:nrt _p(5.0):C8)}
[junit4:junit4] 1> 10764 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10773 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_s,generation=28}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_t,generation=29}
[junit4:junit4] 1> 10774 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 29
[junit4:junit4] 1> 10776 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@c80472c main
[junit4:junit4] 1> 10777 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@c80472c main{StandardDirectoryReader(segments_t:73:nrt _r(5.0):C9)}
[junit4:junit4] 1> 10777 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10778 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10783 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@c80472c main{StandardDirectoryReader(segments_t:73:nrt _r(5.0):C9)}
[junit4:junit4] 1> 10784 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=true&maxSegments=1&wt=javabin&version=2} {add=[48 (1436585604588503040)],optimize=} 0 21
[junit4:junit4] 1> 10786 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@154fed8a
[junit4:junit4] 1> 10792 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 10802 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_t,generation=29}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_u,generation=30}
[junit4:junit4] 1> 10803 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 30
[junit4:junit4] 1> 10805 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@6322c4ef main
[junit4:junit4] 1> 10806 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@6322c4ef main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 10806 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 10806 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 10810 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@6322c4ef main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 11041 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=true,openSearcher=true,waitSearcher=false,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 11043 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_u,generation=30}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_v,generation=31}
[junit4:junit4] 1> 11043 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 31
[junit4:junit4] 1> 11044 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@14fed46d main
[junit4:junit4] 1> 11045 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 11045 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@14fed46d main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 11046 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 11046 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={optimize=true&waitSearcher=false&maxSegments=1&wt=javabin&version=2} {add=[49 (1436585604617863168)],optimize=,optimize=} 0 255
[junit4:junit4] 1> 11048 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 49 is 200
[junit4:junit4] 1> 11049 [concurrentUpdateScheduler-2-thread-1] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@154fed8a
[junit4:junit4] 1> 11051 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@14fed46d main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 211348 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 211348 [TEST-SolrExampleStreamingTest.testWaitOptions-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testWaitOptions
[junit4:junit4] 1> 211350 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_v,generation=31}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_w,generation=32}
[junit4:junit4] 1> 211351 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 32
[junit4:junit4] 1> 211353 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@176bb5c8 main
[junit4:junit4] 1> 211354 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 211354 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@176bb5c8 main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 211356 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 211363 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@176bb5c8 main{StandardDirectoryReader(segments_u:77:nrt _t(5.0):C10)}
[junit4:junit4] 1> 211365 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=javabin&version=2&softCommit=false} {commit=} 0 17
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrExampleStreamingTest -Dtests.method=testWaitOptions -Dtests.seed=C7CC5ABF653B6F33 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=pt_BR -Dtests.timezone=America/Barbados -Dtests.file.encoding=UTF-8
[junit4:junit4] ERROR 202s J1 | SolrExampleStreamingTest.testWaitOptions <<<
[junit4:junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:42206/solr/collection1
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([C7CC5ABF653B6F33:818DD704463D21D0]:0)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:435)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:180)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer.request(ConcurrentUpdateSolrServer.java:256)
[junit4:junit4] > at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4:junit4] > at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:168)
[junit4:junit4] > at org.apache.solr.client.solrj.SolrServer.commit(SolrServer.java:146)
[junit4:junit4] > at org.apache.solr.client.solrj.embedded.SolrExampleStreamingTest.testWaitOptions(SolrExampleStreamingTest.java:103)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:722)
[junit4:junit4] > Caused by: org.apache.http.NoHttpResponseException: The target server failed to respond
[junit4:junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:95)
[junit4:junit4] > at org.apache.http.impl.conn.DefaultHttpResponseParser.parseHead(DefaultHttpResponseParser.java:62)
[junit4:junit4] > at org.apache.http.impl.io.AbstractMessageParser.parse(AbstractMessageParser.java:254)
[junit4:junit4] > at org.apache.http.impl.AbstractHttpClientConnection.receiveResponseHeader(AbstractHttpClientConnection.java:289)
[junit4:junit4] > at org.apache.http.impl.conn.DefaultClientConnection.receiveResponseHeader(DefaultClientConnection.java:252)
[junit4:junit4] > at org.apache.http.impl.conn.ManagedClientConnectionImpl.receiveResponseHeader(ManagedClientConnectionImpl.java:191)
[junit4:junit4] > at org.apache.http.protocol.HttpRequestExecutor.doReceiveResponse(HttpRequestExecutor.java:300)
[junit4:junit4] > at org.apache.http.protocol.HttpRequestExecutor.execute(HttpRequestExecutor.java:127)
[junit4:junit4] > at org.apache.http.impl.client.DefaultRequestDirector.tryExecute(DefaultRequestDirector.java:717)
[junit4:junit4] > at org.apache.http.impl.client.DefaultRequestDirector.execute(DefaultRequestDirector.java:522)
[junit4:junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:906)
[junit4:junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:805)
[junit4:junit4] > at org.apache.http.impl.client.AbstractHttpClient.execute(AbstractHttpClient.java:784)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:365)
[junit4:junit4] > ... 46 more
[junit4:junit4] 1> 211412 [TEST-SolrExampleStreamingTest.testPivotFacetsMissing-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testPivotFacetsMissing
[junit4:junit4] 1> 211428 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@14121e2a realtime
[junit4:junit4] 1> 211429 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585814998908928)} 0 3
[junit4:junit4] 1> 211437 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 211438 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_w,generation=32}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_x,generation=33}
[junit4:junit4] 1> 211439 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 33
[junit4:junit4] 1> 211441 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@5498416 main
[junit4:junit4] 1> 211443 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@5498416 main{StandardDirectoryReader(segments_w:79:nrt)}
[junit4:junit4] 1> 211444 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 211443 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 211451 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@5498416 main{StandardDirectoryReader(segments_w:79:nrt)}
[junit4:junit4] 1> 211453 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 16
[junit4:junit4] 1> 211461 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 211466 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@55f95386
[junit4:junit4] 1> 211723 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[1 (1436585815050289152), 2 (1436585815053434880), 3 (1436585815055532032), 4 (1436585815057629184), 5 (1436585815059726336), 6 (1436585815061823488), 7 (1436585815062872064), 8 (1436585815064969216), 9 (1436585815067066368), 10 (1436585815069163520), ... (12 adds)]} 0 249
[junit4:junit4] 1> 211725 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 1 is 200
[junit4:junit4] 1> 211727 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@55f95386
[junit4:junit4] 1> 211732 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 211742 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_x,generation=33}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_y,generation=34}
[junit4:junit4] 1> 211743 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 34
[junit4:junit4] 1> 211746 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@721bac32 main
[junit4:junit4] 1> 211749 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@721bac32 main{StandardDirectoryReader(segments_y:81:nrt _u(5.0):C12)}
[junit4:junit4] 1> 211750 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 211749 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 211757 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@721bac32 main{StandardDirectoryReader(segments_y:81:nrt _u(5.0):C12)}
[junit4:junit4] 1> 211757 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 26
[junit4:junit4] 1> 211785 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – UnInverted multi-valued field {field=features,memSize=4521,tindexSize=43,time=2,phase1=2,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 211792 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – UnInverted multi-valued field {field=cat,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 1> 211800 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet.missing=true&facet=true&facet.mincount=0&q=*:*&wt=xml&facet.pivot=features,cat&facet.pivot=cat,features&facet.pivot=features,cat,inStock&version=2.2&rows=0} hits=12 status=0 QTime=38
[junit4:junit4] 1> 211819 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&q=*:*&wt=xml&fq={!tag%3Dmytag}-(features:bbb+AND+cat:a+AND+inStock:true)&facet.pivot={!ex%3Dmytag+key%3Dmykey}features,cat&version=2.2&rows=0} hits=11 status=0 QTime=8
[junit4:junit4] 1> 211822 [TEST-SolrExampleStreamingTest.testPivotFacetsMissing-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testPivotFacetsMissing
[junit4:junit4] 1> 211836 [TEST-SolrExampleStreamingTest.testCommitWithinOnAdd-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testCommitWithinOnAdd
[junit4:junit4] 1> 211840 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@6fa47fc5 realtime
[junit4:junit4] 1> 211841 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585815431970816)} 0 2
[junit4:junit4] 1> 211845 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 211847 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_y,generation=34}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_z,generation=35}
[junit4:junit4] 1> 211848 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 35
[junit4:junit4] 1> 211850 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3277a570 main
[junit4:junit4] 1> 211852 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3277a570 main{StandardDirectoryReader(segments_y:83:nrt)}
[junit4:junit4] 1> 211853 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 211853 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 211860 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3277a570 main{StandardDirectoryReader(segments_y:83:nrt)}
[junit4:junit4] 1> 211862 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4] 1> 211870 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=1
[junit4:junit4] 1> 211873 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2d583ceb
[junit4:junit4] 1> 211877 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2} hits=0 status=0 QTime=0
[junit4:junit4] 1> 212141 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id3 (1436585815486496768)]} 0 250
[junit4:junit4] 1> 212143 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id3 is 200
[junit4:junit4] 1> 212144 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2d583ceb
[junit4:junit4] 1> 212395 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 1> 212400 [commitScheduler-7-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@67fff2dd main
[junit4:junit4] 1> 212400 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 212400 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@67fff2dd main{StandardDirectoryReader(segments_z:85:nrt _v(5.0):C1)}
[junit4:junit4] 1> 212401 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 212405 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@67fff2dd main{StandardDirectoryReader(segments_z:85:nrt _v(5.0):C1)}
[junit4:junit4] 1> 212885 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id3&wt=xml&version=2.2} hits=1 status=0 QTime=1
[junit4:junit4] 1> 212890 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@73c7cb79
[junit4:junit4] 1> 213145 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[id4 (1436585816540315648)]} 0 250
[junit4:junit4] 1> 213147 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: id4 is 200
[junit4:junit4] 1> 213149 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@73c7cb79
[junit4:junit4] 1> 213399 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 1> 213408 [commitScheduler-7-thread-1] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@5cd983be main
[junit4:junit4] 1> 213410 [commitScheduler-7-thread-1] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 213410 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@5cd983be main{StandardDirectoryReader(segments_z:87:nrt _v(5.0):C1 _w(5.0):C1)}
[junit4:junit4] 1> 213411 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 213417 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@5cd983be main{StandardDirectoryReader(segments_z:87:nrt _v(5.0):C1 _w(5.0):C1)}
[junit4:junit4] 1> 213896 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:id4&wt=xml&version=2.2} hits=1 status=0 QTime=2
[junit4:junit4] 1> 213900 [TEST-SolrExampleStreamingTest.testCommitWithinOnAdd-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testCommitWithinOnAdd
[junit4:junit4] 1> 213929 [TEST-SolrExampleStreamingTest.testSetNullUpdates-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testSetNullUpdates
[junit4:junit4] 1> 213931 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7e610936
[junit4:junit4] 1> 214185 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdates (1436585817630834688)]} 0 250
[junit4:junit4] 1> 214187 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdates is 200
[junit4:junit4] 1> 214189 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@7e610936
[junit4:junit4] 1> 214193 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 214202 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_z,generation=35}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_10,generation=36}
[junit4:junit4] 1> 214203 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 36
[junit4:junit4] 1> 214206 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@6d2a14a6 main
[junit4:junit4] 1> 214208 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@6d2a14a6 main{StandardDirectoryReader(segments_10:89:nrt _v(5.0):C1 _w(5.0):C1 _x(5.0):C1)}
[junit4:junit4] 1> 214210 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 214210 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 214217 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@6d2a14a6 main{StandardDirectoryReader(segments_10:89:nrt _v(5.0):C1 _w(5.0):C1 _x(5.0):C1)}
[junit4:junit4] 1> 214219 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 26
[junit4:junit4] 1> 214245 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@724f2b58
[junit4:junit4] 1> 214499 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdates (1436585817963233280)]} 0 250
[junit4:junit4] 1> 214502 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdates is 200
[junit4:junit4] 1> 214503 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@724f2b58
[junit4:junit4] 1> 214507 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 214515 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_10,generation=36}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_11,generation=37}
[junit4:junit4] 1> 214516 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 37
[junit4:junit4] 1> 214519 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@1e4546f8 main
[junit4:junit4] 1> 214521 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@1e4546f8 main{StandardDirectoryReader(segments_11:93:nrt _v(5.0):C1 _w(5.0):C1 _y(5.0):C1)}
[junit4:junit4] 1> 214522 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 214522 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 214529 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@1e4546f8 main{StandardDirectoryReader(segments_11:93:nrt _v(5.0):C1 _w(5.0):C1 _y(5.0):C1)}
[junit4:junit4] 1> 214531 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 24
[junit4:junit4] 1> 214539 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdates&wt=xml&version=2.2} hits=1 status=0 QTime=2
[junit4:junit4] 1> 214543 [TEST-SolrExampleStreamingTest.testSetNullUpdates-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testSetNullUpdates
[junit4:junit4] 1> 214565 [TEST-SolrExampleStreamingTest.testUnicode-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testUnicode
[junit4:junit4] 1> 214571 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@24f70c8a realtime
[junit4:junit4] 1> 214573 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585818293534720)} 0 5
[junit4:junit4] 1> 214577 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@57584afb
[junit4:junit4] 1> 214835 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585818313457664), 1 (1436585818315554816), 2 (1436585818316603392), 3 (1436585818317651968), 4 (1436585818319749120), 5 (1436585818320797696), 6 (1436585818321846272), 7 (1436585818322894848), 8 (1436585818323943424), 9 (1436585818326040576), ... (17 adds)]} 0 248
[junit4:junit4] 1> 214839 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 214841 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@57584afb
[junit4:junit4] 1> 214847 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 214857 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_11,generation=37}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_12,generation=38}
[junit4:junit4] 1> 214858 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 38
[junit4:junit4] 1> 214862 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@64608f91 main
[junit4:junit4] 1> 214865 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@64608f91 main{StandardDirectoryReader(segments_12:97:nrt _z(5.0):C17)}
[junit4:junit4] 1> 214867 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 214865 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 214871 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@64608f91 main{StandardDirectoryReader(segments_12:97:nrt _z(5.0):C17)}
[junit4:junit4] 1> 214924 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 78
[junit4:junit4] 1> 214931 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=17} hits=17 status=0 QTime=1
[junit4:junit4] 1> 214945 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@2c880550 realtime
[junit4:junit4] 1> 214946 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585818686750720)} 0 3
[junit4:junit4] 1> 214948 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1614de07
[junit4:junit4] 1> 215204 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585818697236480), 1 (1436585818699333632), 2 (1436585818699333633), 3 (1436585818700382208), 4 (1436585818700382209), 5 (1436585818701430784), 6 (1436585818701430785), 7 (1436585818702479360), 8 (1436585818702479361), 9 (1436585818703527936), ... (15 adds)]} 0 251
[junit4:junit4] 1> 215207 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 215208 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@1614de07
[junit4:junit4] 1> 215213 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 215224 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_12,generation=38}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_13,generation=39}
[junit4:junit4] 1> 215226 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 39
[junit4:junit4] 1> 215230 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@69053172 main
[junit4:junit4] 1> 215232 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@69053172 main{StandardDirectoryReader(segments_13:101:nrt _10(5.0):C15)}
[junit4:junit4] 1> 215233 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 215232 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 215237 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@69053172 main{StandardDirectoryReader(segments_13:101:nrt _10(5.0):C15)}
[junit4:junit4] 1> 215238 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 25
[junit4:junit4] 1> 215248 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=15} hits=15 status=0 QTime=1
[junit4:junit4] 1> 215265 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@25f9c1e8 realtime
[junit4:junit4] 1> 215266 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585819022295040)} 0 3
[junit4:junit4] 1> 215269 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@302979d2
[junit4:junit4] 1> 215524 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585819032780800), 1 (1436585819034877952)]} 0 251
[junit4:junit4] 1> 215526 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 215527 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@302979d2
[junit4:junit4] 1> 215532 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 215538 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_13,generation=39}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_14,generation=40}
[junit4:junit4] 1> 215539 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 40
[junit4:junit4] 1> 215542 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@50c09dc5 main
[junit4:junit4] 1> 215544 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@50c09dc5 main{StandardDirectoryReader(segments_14:105:nrt _11(5.0):C2)}
[junit4:junit4] 1> 215545 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 215545 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 215550 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@50c09dc5 main{StandardDirectoryReader(segments_14:105:nrt _11(5.0):C2)}
[junit4:junit4] 1> 215552 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 20
[junit4:junit4] 1> 215559 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=2} hits=2 status=0 QTime=0
[junit4:junit4] 1> 215570 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@30aded41 realtime
[junit4:junit4] 1> 215571 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585819342110720)} 0 3
[junit4:junit4] 1> 215576 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6ab35f5e
[junit4:junit4] 1> 215832 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585819357839360), 1 (1436585819359936512), 2 (1436585819360985088), 3 (1436585819362033664), 4 (1436585819363082240), 5 (1436585819364130816), 6 (1436585819365179392), 7 (1436585819366227968), 8 (1436585819367276544), 9 (1436585819368325120), ... (14 adds)]} 0 250
[junit4:junit4] 1> 215834 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 215835 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6ab35f5e
[junit4:junit4] 1> 215840 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 215851 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_14,generation=40}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_15,generation=41}
[junit4:junit4] 1> 215852 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 41
[junit4:junit4] 1> 215855 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@732d486e main
[junit4:junit4] 1> 215857 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@732d486e main{StandardDirectoryReader(segments_15:109:nrt _12(5.0):C14)}
[junit4:junit4] 1> 215857 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 215857 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 215862 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@732d486e main{StandardDirectoryReader(segments_15:109:nrt _12(5.0):C14)}
[junit4:junit4] 1> 215864 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 24
[junit4:junit4] 1> 215869 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=14} hits=14 status=0 QTime=1
[junit4:junit4] 1> 215879 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4ff34082 realtime
[junit4:junit4] 1> 215879 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585819666120704)} 0 2
[junit4:junit4] 1> 215882 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b103fcf
[junit4:junit4] 1> 216138 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585819678703616), 1 (1436585819680800768), 2 (1436585819681849344), 3 (1436585819682897920), 4 (1436585819683946496), 5 (1436585819684995072), 6 (1436585819686043648), 7 (1436585819687092224), 8 (1436585819687092225), 9 (1436585819688140800)]} 0 249
[junit4:junit4] 1> 216139 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 216140 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6b103fcf
[junit4:junit4] 1> 216145 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 216154 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_15,generation=41}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_16,generation=42}
[junit4:junit4] 1> 216155 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 42
[junit4:junit4] 1> 216157 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@79159342 main
[junit4:junit4] 1> 216158 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@79159342 main{StandardDirectoryReader(segments_16:113:nrt _13(5.0):C10)}
[junit4:junit4] 1> 216158 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 216158 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 216161 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@79159342 main{StandardDirectoryReader(segments_16:113:nrt _13(5.0):C10)}
[junit4:junit4] 1> 216162 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4] 1> 216168 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=10} hits=10 status=0 QTime=1
[junit4:junit4] 1> 216183 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3e5073bf realtime
[junit4:junit4] 1> 216185 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585819984887808)} 0 3
[junit4:junit4] 1> 216188 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@13df208f
[junit4:junit4] 1> 216445 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585820001665024), 1 (1436585820003762176), 2 (1436585820004810752), 3 (1436585820005859328), 4 (1436585820006907904), 5 (1436585820007956480), 6 (1436585820009005056), 7 (1436585820010053632), 8 (1436585820011102208), 9 (1436585820012150784), ... (24 adds)]} 0 249
[junit4:junit4] 1> 216447 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 216449 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@13df208f
[junit4:junit4] 1> 216454 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 216461 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_16,generation=42}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_17,generation=43}
[junit4:junit4] 1> 216461 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 43
[junit4:junit4] 1> 216463 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@72898110 main
[junit4:junit4] 1> 216464 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@72898110 main{StandardDirectoryReader(segments_17:117:nrt _14(5.0):C24)}
[junit4:junit4] 1> 216464 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 216465 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 216469 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@72898110 main{StandardDirectoryReader(segments_17:117:nrt _14(5.0):C24)}
[junit4:junit4] 1> 216474 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 21
[junit4:junit4] 1> 216479 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=24} hits=24 status=0 QTime=0
[junit4:junit4] 1> 216492 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@7992fd15 realtime
[junit4:junit4] 1> 216493 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585820309946368)} 0 2
[junit4:junit4] 1> 216495 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2125ac0e
[junit4:junit4] 1> 216749 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585820317286400)]} 0 251
[junit4:junit4] 1> 216751 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 216752 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@2125ac0e
[junit4:junit4] 1> 216756 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 216760 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_17,generation=43}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_18,generation=44}
[junit4:junit4] 1> 216761 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 44
[junit4:junit4] 1> 216764 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@5a445a21 main
[junit4:junit4] 1> 216766 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 216766 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@5a445a21 main{StandardDirectoryReader(segments_18:121:nrt _15(5.0):C1)}
[junit4:junit4] 1> 216767 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 216772 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@5a445a21 main{StandardDirectoryReader(segments_18:121:nrt _15(5.0):C1)}
[junit4:junit4] 1> 216773 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 17
[junit4:junit4] 1> 216780 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=1} hits=1 status=0 QTime=0
[junit4:junit4] 1> 216788 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@6b04cfd realtime
[junit4:junit4] 1> 216789 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585820619276288)} 0 4
[junit4:junit4] 1> 216792 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@208e7979
[junit4:junit4] 1> 217047 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585820630810624), 1 (1436585820631859200), 2 (1436585820632907776), 3 (1436585820632907777), 4 (1436585820633956352), 5 (1436585820633956353)]} 0 250
[junit4:junit4] 1> 217048 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 217049 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@208e7979
[junit4:junit4] 1> 217053 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 217058 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_18,generation=44}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_19,generation=45}
[junit4:junit4] 1> 217058 [qtp2047162682-32] INFO org.apache.solr.core.SolrCore – newest commit generation = 45
[junit4:junit4] 1> 217059 [qtp2047162682-32] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@16de3935 main
[junit4:junit4] 1> 217060 [qtp2047162682-32] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 217060 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@16de3935 main{StandardDirectoryReader(segments_19:125:nrt _16(5.0):C6)}
[junit4:junit4] 1> 217061 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 217066 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@16de3935 main{StandardDirectoryReader(segments_19:125:nrt _16(5.0):C6)}
[junit4:junit4] 1> 217068 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 15
[junit4:junit4] 1> 217073 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=6} hits=6 status=0 QTime=0
[junit4:junit4] 1> 217081 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@4293a96c realtime
[junit4:junit4] 1> 217082 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585820926509056)} 0 3
[junit4:junit4] 1> 217088 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6c581399
[junit4:junit4] 1> 217344 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[0 (1436585820942237696), 1 (1436585820944334848), 2 (1436585820945383424), 3 (1436585820946432000), 4 (1436585820947480576), 5 (1436585820948529152), 6 (1436585820949577728), 7 (1436585820950626304), 8 (1436585820951674880), 9 (1436585820952723456), ... (27 adds)]} 0 250
[junit4:junit4] 1> 217346 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: 0 is 200
[junit4:junit4] 1> 217347 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@6c581399
[junit4:junit4] 1> 217352 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 217372 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_19,generation=45}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1a,generation=46}
[junit4:junit4] 1> 217372 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 46
[junit4:junit4] 1> 217375 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@d257ecd main
[junit4:junit4] 1> 217377 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@d257ecd main{StandardDirectoryReader(segments_1a:129:nrt _17(5.0):C27)}
[junit4:junit4] 1> 217377 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 217377 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 217382 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@d257ecd main{StandardDirectoryReader(segments_1a:129:nrt _17(5.0):C27)}
[junit4:junit4] 1> 217383 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 31
[junit4:junit4] 1> 217388 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={q=*:*&wt=xml&version=2.2&rows=27} hits=27 status=0 QTime=0
[junit4:junit4] 1> 217398 [TEST-SolrExampleStreamingTest.testUnicode-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testUnicode
[junit4:junit4] 1> 217423 [TEST-SolrExampleStreamingTest.testRealtimeGet-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testRealtimeGet
[junit4:junit4] 1> 217429 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@400d0551 realtime
[junit4:junit4] 1> 217431 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {deleteByQuery=*:* (-1436585821291413504)} 0 5
[junit4:junit4] 1> 217433 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@16d829b1
[junit4:junit4] 1> 217688 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[DOCID (1436585821301899264)]} 0 251
[junit4:junit4] 1> 217690 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: DOCID is 200
[junit4:junit4] 1> 217691 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@16d829b1
[junit4:junit4] 1> 217695 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 217701 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1a,generation=46}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1b,generation=47}
[junit4:junit4] 1> 217702 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – newest commit generation = 47
[junit4:junit4] 1> 217705 [qtp2047162682-18] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3179e3cb main
[junit4:junit4] 1> 217707 [qtp2047162682-18] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 217707 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3179e3cb main{StandardDirectoryReader(segments_1b:133:nrt _18(5.0):C1)}
[junit4:junit4] 1> 217709 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 217714 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3179e3cb main{StandardDirectoryReader(segments_1b:133:nrt _18(5.0):C1)}
[junit4:junit4] 1> 217715 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 20
[junit4:junit4] 1> 217723 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/get params={id=DOCID&fl=id,name,aaa:[value+v%3Daaa]&wt=javabin&qt=/get&version=2} status=0 QTime=1
[junit4:junit4] 1> 217730 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/get params={id=DOCID&fl=id,name,aaa:[value+v%3Daaa]&wt=xml&qt=/get&version=2.2} status=0 QTime=1
[junit4:junit4] 1> 217732 [TEST-SolrExampleStreamingTest.testRealtimeGet-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testRealtimeGet
[junit4:junit4] 1> 217758 [TEST-SolrExampleStreamingTest.testSetNullUpdateOrder-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testSetNullUpdateOrder
[junit4:junit4] 1> 217760 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@d82ea1e
[junit4:junit4] 1> 218014 [qtp2047162682-32] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdateOrder (1436585821644783616)]} 0 250
[junit4:junit4] 1> 218016 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdateOrder is 200
[junit4:junit4] 1> 218017 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@d82ea1e
[junit4:junit4] 1> 218022 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 218029 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1b,generation=47}
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apache.lucene.store.NativeFSLockFactory@3b90a564; maxCacheMB=0.447265625 maxMergeSizeMB=0.2607421875)),segFN=segments_1c,generation=48}
[junit4:junit4] 1> 218030 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – newest commit generation = 48
[junit4:junit4] 1> 218033 [qtp2047162682-16] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@3a0c9cb8 main
[junit4:junit4] 1> 218034 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@3a0c9cb8 main{StandardDirectoryReader(segments_1c:135:nrt _18(5.0):C1 _19(5.0):C1)}
[junit4:junit4] 1> 218035 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 218035 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 218040 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@3a0c9cb8 main{StandardDirectoryReader(segments_1c:135:nrt _18(5.0):C1 _19(5.0):C1)}
[junit4:junit4] 1> 218042 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 20
[junit4:junit4] 1> 218045 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3622288d
[junit4:junit4] 1> 218299 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {add=[testSetNullUpdateOrder (1436585821945724928)]} 0 250
[junit4:junit4] 1> 218301 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: testSetNullUpdateOrder is 200
[junit4:junit4] 1> 218303 [concurrentUpdateScheduler-1-thread-6] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3622288d
[junit4:junit4] 1> 218307 [qtp2047162682-16] INFO org.apache.solr.update.UpdateHandler – start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 1> 218314 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – SolrDeletionPolicy.onCommit: commits: num=2
[junit4:junit4] 1> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.RAMDirectory@169cbe9b lockFactory=org.apa
[...truncated too long message...]
2682-19] INFO org.apache.solr.core.SolrCore – newest commit generation = 79
[junit4:junit4] 1> 223839 [qtp2047162682-19] INFO org.apache.solr.search.SolrIndexSearcher – Opening Searcher@1ee58592 main
[junit4:junit4] 1> 223839 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener sending requests to Searcher@1ee58592 main{StandardDirectoryReader(segments_27:219:nrt _1y(5.0):C10)}
[junit4:junit4] 1> 223839 [qtp2047162682-19] INFO org.apache.solr.update.UpdateHandler – end_commit_flush
[junit4:junit4] 1> 223840 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – QuerySenderListener done.
[junit4:junit4] 1> 223844 [searcherExecutor-4-thread-1] INFO org.apache.solr.core.SolrCore – [collection1] Registered new searcher Searcher@1ee58592 main{StandardDirectoryReader(segments_27:219:nrt _1y(5.0):C10)}
[junit4:junit4] 1> 223845 [qtp2047162682-19] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={waitSearcher=true&commit=true&wt=xml&version=2.2&softCommit=false} {commit=} 0 14
[junit4:junit4] 1> 223852 [qtp2047162682-45] INFO org.apache.solr.core.SolrCore – UnInverted multi-valued field {field=features,memSize=4564,tindexSize=44,time=0,phase1=0,nTerms=4,bigTerms=2,termInstances=4,uses=0}
[junit4:junit4] 1> 223853 [qtp2047162682-45] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&q=*:*&facet.field=features&wt=xml&version=2.2&rows=0} hits=10 status=0 QTime=3
[junit4:junit4] 1> 223860 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=0&q=*:*&facet.field=features&wt=xml&fq=features:two&version=2.2&rows=0} hits=5 status=0 QTime=1
[junit4:junit4] 1> 223868 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=4&q=*:*&facet.field=features&wt=xml&fq=features:two&version=2.2&rows=0} hits=5 status=0 QTime=2
[junit4:junit4] 1> 223875 [qtp2047162682-46] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/select params={facet=true&facet.mincount=-1&q=*:*&facet.field=features&wt=xml&fq=features:two&version=2.2&rows=0} hits=5 status=0 QTime=1
[junit4:junit4] 1> 223878 [TEST-SolrExampleStreamingTest.testFaceting-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testFaceting
[junit4:junit4] 1> 223896 [TEST-SolrExampleStreamingTest.testErrorHandling-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Starting testErrorHandling
[junit4:junit4] 1> 223912 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – Ignoring exception matching ignore_exception
[junit4:junit4] 1> 223913 [qtp2047162682-19] INFO org.apache.solr.core.SolrCore – [collection1] webapp=/solr path=/analysis/field params={analysis.fieldtype=int&wt=xml&qt=/analysis/field&analysis.fieldvalue=ignore_exception&version=2.2} status=400 QTime=14
[junit4:junit4] 1> 223956 [qtp2047162682-16] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 38
[junit4:junit4] 1> 223957 [qtp2047162682-16] INFO org.apache.solr.core.SolrCore – Ignoring exception matching ignore_exception
[junit4:junit4] 1> 223959 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – starting runner: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3ed4881e
[junit4:junit4] 1> 223963 [qtp2047162682-18] INFO org.apache.solr.update.processor.LogUpdateProcessor – [collection1] webapp=/solr path=/update params={wt=xml&version=2.2} {} 0 1
[junit4:junit4] 1> 223965 [qtp2047162682-18] INFO org.apache.solr.core.SolrCore – Ignoring exception matching uniqueKey
[junit4:junit4] 1> 224212 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – Status for: DOCID is 400
[junit4:junit4] 1> 224213 [concurrentUpdateScheduler-1-thread-7] INFO org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer – finished: org.apache.solr.client.solrj.impl.ConcurrentUpdateSolrServer$Runner@3ed4881e
[junit4:junit4] 1> 224214 [TEST-SolrExampleStreamingTest.testErrorHandling-seed#[C7CC5ABF653B6F33]] INFO org.apache.solr.SolrTestCaseJ4 – ###Ending testErrorHandling
[junit4:junit4] 1> 224437 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CoreContainer – Shutting down CoreContainer instance=358529815
[junit4:junit4] 1> 224438 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCore – [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@752aea81
[junit4:junit4] 1> 224472 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.update.UpdateHandler – closing DirectUpdateHandler2{commits=73,autocommit maxTime=15000ms,autocommits=0,soft autocommits=3,optimizes=8,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=1,cumulative_adds=248,cumulative_deletesById=5,cumulative_deletesByQuery=33,cumulative_errors=1}
[junit4:junit4] 1> 224473 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.update.SolrCoreState – Closing SolrCoreState
[junit4:junit4] 1> 224473 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.update.DefaultSolrCoreState – SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 1> 224474 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.update.DefaultSolrCoreState – closing IndexWriter with IndexWriterCloser
[junit4:junit4] 1> 224475 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.SolrCore – [collection1] Closing main searcher on request.
[junit4:junit4] 1> 224476 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4:junit4] 1> 224477 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index;done=false>>]
[junit4:junit4] 1> 224478 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660/index
[junit4:junit4] 1> 224478 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – looking to close /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660 [CachedDir<<refCount=0;path=/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660;done=false>>]
[junit4:junit4] 1> 224479 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.core.CachingDirectoryFactory – Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleStreamingTest-1370034783660
[junit4:junit4] 1> 224479 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.eclipse.jetty.server.handler.ContextHandler – stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4] 1> 224535 [SUITE-SolrExampleStreamingTest-seed#[C7CC5ABF653B6F33]-worker] INFO org.apache.solr.SolrTestCaseJ4 – ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=FastDecompressionCompressingStoredFields(storedFieldsFormat=CompressingStoredFieldsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=310), termVectorsFormat=CompressingTermVectorsFormat(compressionMode=FAST_DECOMPRESSION, chunkSize=310)), sim=DefaultSimilarity, locale=pt_BR, timezone=America/Barbados
[junit4:junit4] 2> NOTE: Linux 3.2.0-44-generic amd64/Oracle Corporation 1.7.0_21 (64-bit)/cpus=8,threads=11,free=77935000,total=126418944
[junit4:junit4] 2> NOTE: All tests run in this JVM: [SolrExampleStreamingTest]
[junit4:junit4] Completed on J1 in 225.34s, 27 tests, 1 error <<< FAILURES!
[...truncated 40 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:380: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:360: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/build.xml:194: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/solr/common-build.xml:437: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:1240: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/lucene/common-build.xml:884: There were test failures: 46 suites, 271 tests, 1 error
Total time: 46 minutes 10 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0_21 -XX:-UseCompressedOops -XX:+UseConcMarkSweepGC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-trunk-Linux (32bit/jdk1.7.0_21) - Build #
5924 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/5924/
Java: 32bit/jdk1.7.0_21 -client -XX:+UseG1GC
All tests passed
Build Log:
[...truncated 14753 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:380: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:88: The following files contain @author tags, tabs or nocommits:
* solr/test-framework/src/java/org/apache/solr/SolrTestCaseJ4.java
Total time: 46 minutes 31 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 32bit/jdk1.7.0_21 -client -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure
[JENKINS] Lucene-Solr-trunk-Linux (64bit/jdk1.8.0-ea-b91) - Build #
5923 - Still Failing!
Posted by Policeman Jenkins Server <je...@thetaphi.de>.
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Linux/5923/
Java: 64bit/jdk1.8.0-ea-b91 -XX:+UseCompressedOops -XX:+UseG1GC
All tests passed
Build Log:
[...truncated 14745 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:380: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-trunk-Linux/build.xml:88: The following files contain @author tags, tabs or nocommits:
* solr/test-framework/src/java/org/apache/solr/SolrTestCaseJ4.java
Total time: 43 minutes 2 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.8.0-ea-b91 -XX:+UseCompressedOops -XX:+UseG1GC
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure