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/03/12 07:26:24 UTC
[JENKINS] Lucene-Solr-4.x-Linux (64bit/ibm-j9-jdk7) - Build # 4642
- Still Failing!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Linux/4642/
Java: 64bit/ibm-j9-jdk7
1 tests failed.
FAILED: org.apache.solr.client.solrj.embedded.SolrExampleJettyTest.testLukeHandler
Error Message:
IOException occured when talking to server at: https://127.0.0.1:58580/solr
Stack Trace:
org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:58580/solr
at __randomizedtesting.SeedInfo.seed([C6B0C0030A65333F:2D0D1A181423457]:0)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:416)
at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:116)
at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:102)
at org.apache.solr.client.solrj.SolrExampleTests.testLukeHandler(SolrExampleTests.java:770)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
at java.lang.reflect.Method.invoke(Method.java:613)
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:780)
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:353)
... 45 more
Build Log:
[...truncated 10217 lines...]
[junit4:junit4] Suite: org.apache.solr.client.solrj.embedded.SolrExampleJettyTest
[junit4:junit4] 2> 0 T77 oas.SolrJettyTestBase.beforeSolrJettyTestBase Randomized ssl (true) and clientAuth (false)
[junit4:junit4] 2> 1 T77 oas.SolrTestCaseJ4.initCore ####initCore
[junit4:junit4] 2> Creating dataDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/./solrtest-SolrExampleJettyTest-1363069347285
[junit4:junit4] 2> 6 T77 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4:junit4] 2> 15 T77 oejs.Server.doStart jetty-8.1.8.v20121106
[junit4:junit4] 2> 689 T77 oejus.SslContextFactory.doStart Enabled Protocols [TLSv1] of [SSLv3, TLSv1, TLSv1.1, TLSv1.2]
[junit4:junit4] 2> 692 T77 oejs.AbstractConnector.doStart Started SslSelectChannelConnector@127.0.0.1:58580
[junit4:junit4] 2> 693 T77 oass.SolrDispatchFilter.init SolrDispatchFilter.init()
[junit4:junit4] 2> 693 T77 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4:junit4] 2> 694 T77 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr
[junit4:junit4] 2> 694 T77 oasc.CoreContainer$Initializer.initialize looking for solr config file: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/solr.xml
[junit4:junit4] 2> 694 T77 oasc.CoreContainer.<init> New CoreContainer -1126836896
[junit4:junit4] 2> 695 T77 oasc.CoreContainer.load Loading CoreContainer using Solr Home: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/'
[junit4:junit4] 2> 695 T77 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/'
[junit4:junit4] 2> 719 T77 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4:junit4] 2> 720 T77 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http://
[junit4:junit4] 2> 720 T77 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4:junit4] 2> 721 T77 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4:junit4] 2> 721 T77 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4:junit4] 2> 722 T77 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4:junit4] 2> 722 T77 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4:junit4] 2> 723 T77 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4:junit4] 2> 723 T77 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4:junit4] 2> 724 T77 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false
[junit4:junit4] 2> 730 T77 oasc.CoreContainer.load Registering Log Listener
[junit4:junit4] 2> 745 T87 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/collection1
[junit4:junit4] 2> 746 T87 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/collection1/'
[junit4:junit4] 2> 786 T87 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4:junit4] 2> 818 T87 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4:junit4] 2> 899 T87 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4:junit4] 2> 900 T87 oass.IndexSchema.readSchema Reading Solr Schema
[junit4:junit4] 2> 943 T87 oass.IndexSchema.readSchema Schema name=example
[junit4:junit4] 2> 1580 T87 oass.IndexSchema.readSchema unique key field: id
[junit4:junit4] 2> 1601 T87 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1606 T87 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4:junit4] 2> 1650 T87 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1651 T87 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/collection1/, dataDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/
[junit4:junit4] 2> 1652 T87 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4:junit4] 2> 1652 T87 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4:junit4] 2> 1653 T87 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4:junit4] 2> 1653 T87 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4:junit4] 2> 1654 T87 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285 forceNew: false
[junit4:junit4] 2> 1655 T87 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/index/
[junit4:junit4] 2> 1655 T87 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory '/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/index' doesn't exist. Creating new index...
[junit4:junit4] 2> 1662 T87 oasc.CachingDirectoryFactory.get return new directory for /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/index forceNew: false
[junit4:junit4] 2> 1687 T87 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 1688 T87 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 1690 T87 oasc.SolrCore.initWriters created json: solr.JSONResponseWriter
[junit4:junit4] 2> 1691 T87 oasc.SolrCore.initWriters adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4:junit4] 2> 1692 T87 oasc.SolrCore.initWriters created velocity: solr.VelocityResponseWriter
[junit4:junit4] 2> 1692 T87 oasc.SolrCore.initWriters created xslt: solr.XSLTResponseWriter
[junit4:junit4] 2> 1693 T87 oasr.XSLTResponseWriter.init xsltCacheLifetimeSeconds=5
[junit4:junit4] 2> 1694 T87 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4:junit4] 2> 1695 T87 oasc.RequestHandlers.initHandlersFromConfig created /query: solr.SearchHandler
[junit4:junit4] 2> 1696 T87 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4:junit4] 2> 1696 T87 oasc.RequestHandlers.initHandlersFromConfig created /browse: solr.SearchHandler
[junit4:junit4] 2> 1697 T87 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4:junit4] 2> 1697 T87 oasc.RequestHandlers.initHandlersFromConfig created /update/json: solr.JsonUpdateRequestHandler
[junit4:junit4] 2> 1698 T87 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: solr.CSVRequestHandler
[junit4:junit4] 2> 1698 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 2> 1699 T87 oasc.RequestHandlers.initHandlersFromConfig created /update/extract: solr.extraction.ExtractingRequestHandler
[junit4:junit4] 2> 1699 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4:junit4] 2> 1700 T87 oasc.RequestHandlers.initHandlersFromConfig created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4:junit4] 2> 1700 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 2> 1701 T87 oasc.RequestHandlers.initHandlersFromConfig created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4:junit4] 2> 1701 T87 oasc.RequestHandlers.initHandlersFromConfig created /admin/: solr.admin.AdminHandlers
[junit4:junit4] 2> 1702 T87 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4:junit4] 2> 1704 T87 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4:junit4] 2> 1709 T87 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4:junit4] 2> 1711 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 2> 1714 T87 oasc.RequestHandlers.initHandlersFromConfig created /spell: solr.SearchHandler
[junit4:junit4] 2> 1715 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 2> 1715 T87 oasc.RequestHandlers.initHandlersFromConfig created /tvrh: solr.SearchHandler
[junit4:junit4] 2> 1715 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 2> 1716 T87 oasc.RequestHandlers.initHandlersFromConfig created /terms: solr.SearchHandler
[junit4:junit4] 2> 1716 T87 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4:junit4] 2> 1717 T87 oasc.RequestHandlers.initHandlersFromConfig created /elevate: solr.SearchHandler
[junit4:junit4] 2> 1719 T87 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1721 T87 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1723 T87 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4:junit4] 2> 1740 T87 oass.SolrIndexSearcher.<init> Opening Searcher@37e5f9e5 main
[junit4:junit4] 2> 1741 T87 oasu.UpdateHandler.clearLog Clearing tlog files, tlogDir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/tlog
[junit4:junit4] 2> 1742 T87 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 15000ms;
[junit4:junit4] 2> 1743 T87 oasu.CommitTracker.<init> Soft AutoCommit: disabled
[junit4:junit4] 2> 1743 T87 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4:junit4] 2> 1744 T87 oass.DirectSolrSpellChecker.init init: {name=default,field=name,classname=solr.DirectSolrSpellChecker,distanceMeasure=internal,accuracy=0.5,maxEdits=2,minPrefix=1,maxInspections=5,minQueryLength=4,maxQueryFrequency=0.01}
[junit4:junit4] 2> 1745 T87 oashc.SpellCheckComponent.inform No queryConverter defined, using default converter
[junit4:junit4] 2> 1746 T87 oashc.QueryElevationComponent.inform Loading QueryElevation from: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/example/solr/collection1/conf/elevate.xml
[junit4:junit4] 2> 1778 T87 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4:junit4] 2> 1779 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@37e5f9e5 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1779 T87 oasc.CoreContainer.registerCore registering core: collection1
[junit4:junit4] 2> ASYNC NEW_CORE C9 name=collection1 org.apache.solr.core.SolrCore@fbdbb1
[junit4:junit4] 2> 1781 T88 C9 REQ [collection1] webapp=null path=null params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher} hits=0 status=0 QTime=2
[junit4:junit4] 2> 1782 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 1782 T88 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
[junit4:junit4] 2> 1783 T88 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
[junit4:junit4] 2> 1783 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@37e5f9e5 main{StandardDirectoryReader(segments_1:1)}
[junit4:junit4] 2> 1784 T77 oass.SolrDispatchFilter.init user.dir=/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1
[junit4:junit4] 2> 1785 T77 oass.SolrDispatchFilter.init SolrDispatchFilter.init() done
[junit4:junit4] 2> 1785 T77 oas.SolrJettyTestBase.createJetty Jetty Assigned Port#58580
[junit4:junit4] 2> 1803 T77 oas.SolrTestCaseJ4.setUp ###Starting testSetNullUpdates
[junit4:junit4] 2> 1805 T77 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnections=128&maxConnectionsPerHost=32&followRedirects=false
[junit4:junit4] 2> 3791 T85 C9 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> 3793 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 1[segments_1]
[junit4:junit4] 2> 3801 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[testSetNullUpdates (1429281807864430592)]} 0 16
[junit4:junit4] 2> 3813 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 3904 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1,generation=1,filenames=[segments_1]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_2,generation=2,filenames=[_0.si, segments_2, _0_Lucene41_0.doc, _0_Lucene41_0.tim, _0.fnm, _0.fdt, _0_Lucene41_0.tip, _0.fdx]
[junit4:junit4] 2> 3904 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 2[_0.si, segments_2, _0_Lucene41_0.doc, _0_Lucene41_0.tim, _0.fnm, _0.fdt, _0_Lucene41_0.tip, _0.fdx]
[junit4:junit4] 2> 3912 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@957b970a main
[junit4:junit4] 2> 3913 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@957b970a main{StandardDirectoryReader(segments_2:3 _0(4.3):C1)}
[junit4:junit4] 2> 3913 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3913 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 3914 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@957b970a main{StandardDirectoryReader(segments_2:3 _0(4.3):C1)}
[junit4:junit4] 2> 3914 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 101
[junit4:junit4] 2> 3931 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[testSetNullUpdates (1429281808013328384)]} 0 5
[junit4:junit4] 2> 3939 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 3974 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_2,generation=2,filenames=[_0.si, segments_2, _0_Lucene41_0.doc, _0_Lucene41_0.tim, _0.fnm, _0.fdt, _0_Lucene41_0.tip, _0.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_3,generation=3,filenames=[_1.si, segments_3, _1_Lucene41_0.doc, _1_Lucene41_0.tim, _1.fnm, _1.fdt, _1_Lucene41_0.tip, _1.fdx]
[junit4:junit4] 2> 3978 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 3[_1.si, segments_3, _1_Lucene41_0.doc, _1_Lucene41_0.tim, _1.fnm, _1.fdt, _1_Lucene41_0.tip, _1.fdx]
[junit4:junit4] 2> 3994 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@eefe71a main
[junit4:junit4] 2> 3996 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@eefe71a main{StandardDirectoryReader(segments_3:7 _1(4.3):C1)}
[junit4:junit4] 2> 3996 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 3996 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 3998 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@eefe71a main{StandardDirectoryReader(segments_3:7 _1(4.3):C1)}
[junit4:junit4] 2> 3999 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 60
[junit4:junit4] 2> 4004 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=id:testSetNullUpdates&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 4006 T77 oas.SolrTestCaseJ4.tearDown ###Ending testSetNullUpdates
[junit4:junit4] 2> 4024 T77 oas.SolrTestCaseJ4.setUp ###Starting testAddRetrieve
[junit4:junit4] 2> 4035 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@5075ea4a realtime
[junit4:junit4] 2> 4036 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281808119234560)} 0 7
[junit4:junit4] 2> 4048 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[id1 (1429281808132866048), id2 (1429281808137060352)]} 0 6
[junit4:junit4] 2> 4054 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4093 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_3,generation=3,filenames=[_1.si, segments_3, _1_Lucene41_0.doc, _1_Lucene41_0.tim, _1.fnm, _1.fdt, _1_Lucene41_0.tip, _1.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_4,generation=4,filenames=[_2.si, _2.nvd, _2_Lucene41_0.pos, segments_4, _2_Lucene41_0.doc, _2_Lucene41_0.tim, _2_Lucene41_0.tip, _2.nvm, _2.fnm, _2.fdt, _2.fdx]
[junit4:junit4] 2> 4094 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 4[_2.si, _2.nvd, _2_Lucene41_0.pos, segments_4, _2_Lucene41_0.doc, _2_Lucene41_0.tim, _2_Lucene41_0.tip, _2.nvm, _2.fnm, _2.fdt, _2.fdx]
[junit4:junit4] 2> 4100 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@98bbfdaa main
[junit4:junit4] 2> 4104 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@98bbfdaa main{StandardDirectoryReader(segments_4:11:nrt _2(4.3):C2)}
[junit4:junit4] 2> 4105 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4106 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@98bbfdaa main{StandardDirectoryReader(segments_4:11:nrt _2(4.3):C2)}
[junit4:junit4] 2> 4107 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4107 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 53
[junit4:junit4] 2> 4123 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin&sort=price+asc} hits=2 status=0 QTime=10
[junit4:junit4] 2> 4136 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[id1 (1429281808226189312), id2 (1429281808229335040)]} 0 5
[junit4:junit4] 2> 4141 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4174 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_4,generation=4,filenames=[_2.si, _2.nvd, _2_Lucene41_0.pos, segments_4, _2_Lucene41_0.doc, _2_Lucene41_0.tim, _2_Lucene41_0.tip, _2.nvm, _2.fnm, _2.fdt, _2.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_5,generation=5,filenames=[_3.si, _3.fdx, _3_Lucene41_0.pos, _3.nvd, _3_Lucene41_0.doc, _3_Lucene41_0.tim, segments_5, _3_Lucene41_0.tip, _3.nvm, _3.fnm, _3.fdt]
[junit4:junit4] 2> 4174 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 5[_3.si, _3.fdx, _3_Lucene41_0.pos, _3.nvd, _3_Lucene41_0.doc, _3_Lucene41_0.tim, segments_5, _3_Lucene41_0.tip, _3.nvm, _3.fnm, _3.fdt]
[junit4:junit4] 2> 4180 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@79e1723a main
[junit4:junit4] 2> 4183 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@79e1723a main{StandardDirectoryReader(segments_5:15:nrt _3(4.3):C2)}
[junit4:junit4] 2> 4183 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4183 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4184 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@79e1723a main{StandardDirectoryReader(segments_5:15:nrt _3(4.3):C2)}
[junit4:junit4] 2> 4186 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 45
[junit4:junit4] 2> 4190 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin&sort=price+asc} hits=2 status=0 QTime=0
[junit4:junit4] 2> 4197 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=name:h?llo&version=2&wt=javabin&sort=price+asc} hits=1 status=0 QTime=2
[junit4:junit4] 2> 4199 T77 oas.SolrTestCaseJ4.tearDown ###Ending testAddRetrieve
[junit4:junit4] 2> 4214 T77 oas.SolrTestCaseJ4.setUp ###Starting testPivotFacets
[junit4:junit4] 2> 4219 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@7c62af0d realtime
[junit4:junit4] 2> 4220 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281808316366848)} 0 3
[junit4:junit4] 2> 4224 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4263 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_5,generation=5,filenames=[_3.si, _3.fdx, _3_Lucene41_0.pos, _3.nvd, _3_Lucene41_0.doc, _3_Lucene41_0.tim, segments_5, _3_Lucene41_0.tip, _3.nvm, _3.fnm, _3.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_6,generation=6,filenames=[segments_6]
[junit4:junit4] 2> 4264 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 6[segments_6]
[junit4:junit4] 2> 4267 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@bb5efd08 main
[junit4:junit4] 2> 4270 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@bb5efd08 main{StandardDirectoryReader(segments_5:17:nrt)}
[junit4:junit4] 2> 4270 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4271 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4272 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bb5efd08 main{StandardDirectoryReader(segments_5:17:nrt)}
[junit4:junit4] 2> 4273 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 49
[junit4:junit4] 2> 4280 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 4301 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1 (1429281808388718592), 2 (1429281808392912896), 3 (1429281808393961472), 4 (1429281808395010048), 5 (1429281808396058624), 6 (1429281808397107200), 7 (1429281808398155776), 8 (1429281808399204352), 9 (1429281808400252928), 10 (1429281808401301504), ... (12 adds)]} 0 15
[junit4:junit4] 2> 4305 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4353 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_6,generation=6,filenames=[segments_6]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_7,generation=7,filenames=[_4_Lucene41_0.pos, _4.fdx, _4.nvd, _4_Lucene41_0.doc, _4_Lucene41_0.tim, _4_Lucene41_0.tip, segments_7, _4.nvm, _4.fnm, _4.fdt, _4.si]
[junit4:junit4] 2> 4354 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 7[_4_Lucene41_0.pos, _4.fdx, _4.nvd, _4_Lucene41_0.doc, _4_Lucene41_0.tim, _4_Lucene41_0.tip, segments_7, _4.nvm, _4.fnm, _4.fdt, _4.si]
[junit4:junit4] 2> 4358 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@4634c03f main
[junit4:junit4] 2> 4359 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4634c03f main{StandardDirectoryReader(segments_7:19:nrt _4(4.3):C12)}
[junit4:junit4] 2> 4359 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4359 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4360 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4634c03f main{StandardDirectoryReader(segments_7:19:nrt _4(4.3):C12)}
[junit4:junit4] 2> 4360 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 55
[junit4:junit4] 2> 4382 T85 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=features,memSize=4521,tindexSize=43,time=1,phase1=1,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 2> 4385 T85 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=cat,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 2> 4389 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.mincount=0&facet=true&version=2&rows=0&facet.pivot=features,cat&facet.pivot=cat,features&facet.pivot=features,cat,inStock&wt=javabin&facet.missing=false} hits=12 status=0 QTime=24
[junit4:junit4] 2> 4402 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.mincount=0&facet=true&version=2&rows=0&fq={!tag%3Dmytag}-(features:bbb+AND+cat:a+AND+inStock:true)&facet.pivot={!ex%3Dmytag+key%3Dmykey}features,cat&wt=javabin} hits=11 status=0 QTime=7
[junit4:junit4] 2> 4404 T77 oas.SolrTestCaseJ4.tearDown ###Ending testPivotFacets
[junit4:junit4] 2> 4413 T77 oas.SolrTestCaseJ4.setUp ###Starting testUnicode
[junit4:junit4] 2> 4421 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@ec35a672 realtime
[junit4:junit4] 2> 4422 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808527130624)} 0 4
[junit4:junit4] 2> 4443 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281808546004992), 1 (1429281808548102144), 2 (1429281808549150720), 3 (1429281808549150721), 4 (1429281808550199296), 5 (1429281808550199297), 6 (1429281808551247872), 7 (1429281808552296448), 8 (1429281808552296449)]} 0 7
[junit4:junit4] 2> 4447 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4474 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_7,generation=7,filenames=[_4_Lucene41_0.pos, _4.fdx, _4.nvd, _4_Lucene41_0.doc, _4_Lucene41_0.tim, _4_Lucene41_0.tip, segments_7, _4.nvm, _4.fnm, _4.fdt, _4.si]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_8,generation=8,filenames=[_5.fdx, _5_Lucene41_0.doc, _5_Lucene41_0.tim, _5_Lucene41_0.tip, segments_8, _5.fnm, _5.si, _5.fdt]
[junit4:junit4] 2> 4474 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 8[_5.fdx, _5_Lucene41_0.doc, _5_Lucene41_0.tim, _5_Lucene41_0.tip, segments_8, _5.fnm, _5.si, _5.fdt]
[junit4:junit4] 2> 4479 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@be4a119c main
[junit4:junit4] 2> 4480 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@be4a119c main{StandardDirectoryReader(segments_8:23:nrt _5(4.3):C9)}
[junit4:junit4] 2> 4480 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4481 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4481 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@be4a119c main{StandardDirectoryReader(segments_8:23:nrt _5(4.3):C9)}
[junit4:junit4] 2> 4483 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 36
[junit4:junit4] 2> 4487 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=9&wt=xml} hits=9 status=0 QTime=0
[junit4:junit4] 2> 4497 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@4f3a275b realtime
[junit4:junit4] 2> 4497 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808607870976)} 0 2
[junit4:junit4] 2> 4523 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281808619405312), 1 (1429281808621502464), 2 (1429281808622551040), 3 (1429281808622551041), 4 (1429281808623599616), 5 (1429281808624648192), 6 (1429281808624648193), 7 (1429281808625696768), 8 (1429281808626745344), 9 (1429281808626745345), ... (23 adds)]} 0 17
[junit4:junit4] 2> 4528 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4574 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_8,generation=8,filenames=[_5.fdx, _5_Lucene41_0.doc, _5_Lucene41_0.tim, _5_Lucene41_0.tip, segments_8, _5.fnm, _5.si, _5.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_9,generation=9,filenames=[_6_Lucene41_0.doc, _6_Lucene41_0.tim, _6.fdx, _6_Lucene41_0.tip, segments_9, _6.si, _6.fnm, _6.fdt]
[junit4:junit4] 2> 4575 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 9[_6_Lucene41_0.doc, _6_Lucene41_0.tim, _6.fdx, _6_Lucene41_0.tip, segments_9, _6.si, _6.fnm, _6.fdt]
[junit4:junit4] 2> 4579 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@26371e73 main
[junit4:junit4] 2> 4580 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@26371e73 main{StandardDirectoryReader(segments_9:27:nrt _6(4.3):C23)}
[junit4:junit4] 2> 4580 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4581 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4581 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@26371e73 main{StandardDirectoryReader(segments_9:27:nrt _6(4.3):C23)}
[junit4:junit4] 2> 4582 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 54
[junit4:junit4] 2> 4587 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=23&wt=xml} hits=23 status=0 QTime=1
[junit4:junit4] 2> 4609 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@eaeed821 realtime
[junit4:junit4] 2> 4610 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808725311488)} 0 3
[junit4:junit4] 2> 4627 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281808735797248), 1 (1429281808737894400), 2 (1429281808737894401), 3 (1429281808738942976), 4 (1429281808738942977), 5 (1429281808739991552), 6 (1429281808739991553), 7 (1429281808741040128), 8 (1429281808741040129), 9 (1429281808742088704), ... (14 adds)]} 0 10
[junit4:junit4] 2> 4632 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4664 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_9,generation=9,filenames=[_6_Lucene41_0.doc, _6_Lucene41_0.tim, _6.fdx, _6_Lucene41_0.tip, segments_9, _6.si, _6.fnm, _6.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_a,generation=10,filenames=[_7.fdt, _7_Lucene41_0.doc, _7_Lucene41_0.tim, segments_a, _7.fdx, _7_Lucene41_0.tip, _7.si, _7.fnm]
[junit4:junit4] 2> 4664 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 10[_7.fdt, _7_Lucene41_0.doc, _7_Lucene41_0.tim, segments_a, _7.fdx, _7_Lucene41_0.tip, _7.si, _7.fnm]
[junit4:junit4] 2> 4669 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@ce331a13 main
[junit4:junit4] 2> 4670 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ce331a13 main{StandardDirectoryReader(segments_a:31:nrt _7(4.3):C14)}
[junit4:junit4] 2> 4670 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4671 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4671 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ce331a13 main{StandardDirectoryReader(segments_a:31:nrt _7(4.3):C14)}
[junit4:junit4] 2> 4673 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 41
[junit4:junit4] 2> 4678 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=14&wt=xml} hits=14 status=0 QTime=1
[junit4:junit4] 2> 4693 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@393c4c9b realtime
[junit4:junit4] 2> 4694 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808813391872)} 0 3
[junit4:junit4] 2> 4703 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281808822829056), 1 (1429281808824926208), 2 (1429281808824926209)]} 0 3
[junit4:junit4] 2> 4709 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4734 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_a,generation=10,filenames=[_7.fdt, _7_Lucene41_0.doc, _7_Lucene41_0.tim, segments_a, _7.fdx, _7_Lucene41_0.tip, _7.si, _7.fnm]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_b,generation=11,filenames=[_8_Lucene41_0.doc, _8_Lucene41_0.tim, _8.fnm, _8.fdt, _8_Lucene41_0.tip, segments_b, _8.fdx, _8.si]
[junit4:junit4] 2> 4735 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 11[_8_Lucene41_0.doc, _8_Lucene41_0.tim, _8.fnm, _8.fdt, _8_Lucene41_0.tip, segments_b, _8.fdx, _8.si]
[junit4:junit4] 2> 4741 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@4808dece main
[junit4:junit4] 2> 4743 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4808dece main{StandardDirectoryReader(segments_b:35:nrt _8(4.3):C3)}
[junit4:junit4] 2> 4743 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4743 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4744 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4808dece main{StandardDirectoryReader(segments_b:35:nrt _8(4.3):C3)}
[junit4:junit4] 2> 4745 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 36
[junit4:junit4] 2> 4753 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=3&wt=xml} hits=3 status=0 QTime=0
[junit4:junit4] 2> 4762 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@474ed8d3 realtime
[junit4:junit4] 2> 4763 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808886792192)} 0 2
[junit4:junit4] 2> 4789 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281808899375104), 1 (1429281808901472256), 2 (1429281808901472257), 3 (1429281808902520832), 4 (1429281808902520833), 5 (1429281808903569408), 6 (1429281808904617984), 7 (1429281808904617985), 8 (1429281808905666560), 9 (1429281808905666561), ... (22 adds)]} 0 17
[junit4:junit4] 2> 4795 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4824 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_b,generation=11,filenames=[_8_Lucene41_0.doc, _8_Lucene41_0.tim, _8.fnm, _8.fdt, _8_Lucene41_0.tip, segments_b, _8.fdx, _8.si]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_c,generation=12,filenames=[_9.fnm, _9.fdt, _9_Lucene41_0.tip, segments_c, _9.fdx, _9.si, _9_Lucene41_0.doc, _9_Lucene41_0.tim]
[junit4:junit4] 2> 4831 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 12[_9.fnm, _9.fdt, _9_Lucene41_0.tip, segments_c, _9.fdx, _9.si, _9_Lucene41_0.doc, _9_Lucene41_0.tim]
[junit4:junit4] 2> 4836 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3d2a07ec main
[junit4:junit4] 2> 4837 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3d2a07ec main{StandardDirectoryReader(segments_c:39:nrt _9(4.3):C22)}
[junit4:junit4] 2> 4838 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4838 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3d2a07ec main{StandardDirectoryReader(segments_c:39:nrt _9(4.3):C22)}
[junit4:junit4] 2> 4838 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4840 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 45
[junit4:junit4] 2> 4852 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=22&wt=xml} hits=22 status=0 QTime=1
[junit4:junit4] 2> 4868 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@9fb5b3dc realtime
[junit4:junit4] 2> 4869 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {deleteByQuery=*:* (-1429281808996892672)} 0 3
[junit4:junit4] 2> 4882 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2.2&wt=xml} {add=[0 (1429281809006329856), 1 (1429281809008427008), 2 (1429281809008427009), 3 (1429281809009475584), 4 (1429281809009475585), 5 (1429281809010524160), 6 (1429281809010524161), 7 (1429281809010524162), 8 (1429281809011572736), 9 (1429281809011572737), ... (12 adds)]} 0 7
[junit4:junit4] 2> 4887 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 4924 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_c,generation=12,filenames=[_9.fnm, _9.fdt, _9_Lucene41_0.tip, segments_c, _9.fdx, _9.si, _9_Lucene41_0.doc, _9_Lucene41_0.tim]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_d,generation=13,filenames=[_a.si, segments_d, _a_Lucene41_0.doc, _a_Lucene41_0.tim, _a.fnm, _a.fdt, _a_Lucene41_0.tip, _a.fdx]
[junit4:junit4] 2> 4925 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 13[_a.si, segments_d, _a_Lucene41_0.doc, _a_Lucene41_0.tim, _a.fnm, _a.fdt, _a_Lucene41_0.tip, _a.fdx]
[junit4:junit4] 2> 4931 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@2c09ce68 main
[junit4:junit4] 2> 4935 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2c09ce68 main{StandardDirectoryReader(segments_d:43:nrt _a(4.3):C12)}
[junit4:junit4] 2> 4935 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 4935 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 4936 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2c09ce68 main{StandardDirectoryReader(segments_d:43:nrt _a(4.3):C12)}
[junit4:junit4] 2> 4939 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2.2&waitSearcher=true&wt=xml} {commit=} 0 52
[junit4:junit4] 2> 4945 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2.2&rows=12&wt=xml} hits=12 status=0 QTime=0
[junit4:junit4] 2> 4957 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@94e3448 realtime
[junit4:junit4] 2> 4957 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809090215936)} 0 2
[junit4:junit4] 2> 4980 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 (1429281809101750272), 1 (1429281809103847424), 2 (1429281809103847425), 3 (1429281809104896000), 4 (1429281809104896001), 5 (1429281809105944576), 6 (1429281809106993152), 7 (1429281809106993153), 8 (1429281809108041728), 9 (1429281809108041729), ... (22 adds)]} 0 15
[junit4:junit4] 2> 4985 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5014 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_d,generation=13,filenames=[_a.si, segments_d, _a_Lucene41_0.doc, _a_Lucene41_0.tim, _a.fnm, _a.fdt, _a_Lucene41_0.tip, _a.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_e,generation=14,filenames=[_b.si, _b_Lucene41_0.doc, _b_Lucene41_0.tim, segments_e, _b_Lucene41_0.tip, _b.fnm, _b.fdt, _b.fdx]
[junit4:junit4] 2> 5015 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 14[_b.si, _b_Lucene41_0.doc, _b_Lucene41_0.tim, segments_e, _b_Lucene41_0.tip, _b.fnm, _b.fdt, _b.fdx]
[junit4:junit4] 2> 5018 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@a3117492 main
[junit4:junit4] 2> 5020 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@a3117492 main{StandardDirectoryReader(segments_e:47:nrt _b(4.3):C22)}
[junit4:junit4] 2> 5020 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5020 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5021 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a3117492 main{StandardDirectoryReader(segments_e:47:nrt _b(4.3):C22)}
[junit4:junit4] 2> 5022 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 37
[junit4:junit4] 2> 5027 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=22&wt=javabin} hits=22 status=0 QTime=1
[junit4:junit4] 2> 5039 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@26f46c3 realtime
[junit4:junit4] 2> 5040 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809175150592)} 0 4
[junit4:junit4] 2> 5065 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 (1429281809188782080), 1 (1429281809189830656), 2 (1429281809190879232), 3 (1429281809191927808), 4 (1429281809191927809), 5 (1429281809192976384), 6 (1429281809194024960), 7 (1429281809195073536), 8 (1429281809195073537), 9 (1429281809196122112), ... (22 adds)]} 0 17
[junit4:junit4] 2> 5069 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5104 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_e,generation=14,filenames=[_b.si, _b_Lucene41_0.doc, _b_Lucene41_0.tim, segments_e, _b_Lucene41_0.tip, _b.fnm, _b.fdt, _b.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_f,generation=15,filenames=[_c.si, _c.fdx, _c_Lucene41_0.doc, _c_Lucene41_0.tim, segments_f, _c_Lucene41_0.tip, _c.fnm, _c.fdt]
[junit4:junit4] 2> 5105 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 15[_c.si, _c.fdx, _c_Lucene41_0.doc, _c_Lucene41_0.tim, segments_f, _c_Lucene41_0.tip, _c.fnm, _c.fdt]
[junit4:junit4] 2> 5109 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@787bcf98 main
[junit4:junit4] 2> 5111 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@787bcf98 main{StandardDirectoryReader(segments_f:51:nrt _c(4.3):C22)}
[junit4:junit4] 2> 5111 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5111 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5111 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@787bcf98 main{StandardDirectoryReader(segments_f:51:nrt _c(4.3):C22)}
[junit4:junit4] 2> 5113 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 44
[junit4:junit4] 2> 5118 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=22&wt=javabin} hits=22 status=0 QTime=1
[junit4:junit4] 2> 5129 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3fad5925 realtime
[junit4:junit4] 2> 5129 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809270571008)} 0 2
[junit4:junit4] 2> 5167 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 (1429281809280008192), 1 (1429281809282105344), 2 (1429281809282105345), 3 (1429281809283153920), 4 (1429281809284202496), 5 (1429281809284202497), 6 (1429281809285251072), 7 (1429281809285251073), 8 (1429281809286299648), 9 (1429281809286299649), ... (24 adds)]} 0 31
[junit4:junit4] 2> 5174 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5204 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_f,generation=15,filenames=[_c.si, _c.fdx, _c_Lucene41_0.doc, _c_Lucene41_0.tim, segments_f, _c_Lucene41_0.tip, _c.fnm, _c.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_g,generation=16,filenames=[_d.fdx, _d_Lucene41_0.doc, _d_Lucene41_0.tim, _d_Lucene41_0.tip, segments_g, _d.fnm, _d.fdt, _d.si]
[junit4:junit4] 2> 5204 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 16[_d.fdx, _d_Lucene41_0.doc, _d_Lucene41_0.tim, _d_Lucene41_0.tip, segments_g, _d.fnm, _d.fdt, _d.si]
[junit4:junit4] 2> 5209 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@bba9a344 main
[junit4:junit4] 2> 5212 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@bba9a344 main{StandardDirectoryReader(segments_g:55:nrt _d(4.3):C24)}
[junit4:junit4] 2> 5213 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5214 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bba9a344 main{StandardDirectoryReader(segments_g:55:nrt _d(4.3):C24)}
[junit4:junit4] 2> 5216 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5216 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 42
[junit4:junit4] 2> 5222 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=24&wt=javabin} hits=24 status=0 QTime=1
[junit4:junit4] 2> 5233 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@a05ab63a realtime
[junit4:junit4] 2> 5234 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809380671488)} 0 3
[junit4:junit4] 2> 5259 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 (1429281809392205824), 1 (1429281809395351552), 2 (1429281809395351553), 3 (1429281809396400128), 4 (1429281809396400129), 5 (1429281809397448704), 6 (1429281809398497280), 7 (1429281809398497281), 8 (1429281809399545856), 9 (1429281809400594432), ... (22 adds)]} 0 16
[junit4:junit4] 2> 5264 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5304 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_g,generation=16,filenames=[_d.fdx, _d_Lucene41_0.doc, _d_Lucene41_0.tim, _d_Lucene41_0.tip, segments_g, _d.fnm, _d.fdt, _d.si]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_h,generation=17,filenames=[_e.fdx, _e_Lucene41_0.doc, _e_Lucene41_0.tim, _e_Lucene41_0.tip, segments_h, _e.fnm, _e.si, _e.fdt]
[junit4:junit4] 2> 5305 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 17[_e.fdx, _e_Lucene41_0.doc, _e_Lucene41_0.tim, _e_Lucene41_0.tip, segments_h, _e.fnm, _e.si, _e.fdt]
[junit4:junit4] 2> 5308 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3f0b5853 main
[junit4:junit4] 2> 5312 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3f0b5853 main{StandardDirectoryReader(segments_h:59:nrt _e(4.3):C22)}
[junit4:junit4] 2> 5312 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5314 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3f0b5853 main{StandardDirectoryReader(segments_h:59:nrt _e(4.3):C22)}
[junit4:junit4] 2> 5314 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5315 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 51
[junit4:junit4] 2> 5321 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=22&wt=javabin} hits=22 status=0 QTime=0
[junit4:junit4] 2> 5331 T77 oas.SolrTestCaseJ4.tearDown ###Ending testUnicode
[junit4:junit4] 2> 5348 T77 oas.SolrTestCaseJ4.setUp ###Starting testStatistics
[junit4:junit4] 2> 5353 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@dcb4428a realtime
[junit4:junit4] 2> 5355 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809505452032)} 0 4
[junit4:junit4] 2> 5385 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5404 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_h,generation=17,filenames=[_e.fdx, _e_Lucene41_0.doc, _e_Lucene41_0.tim, _e_Lucene41_0.tip, segments_h, _e.fnm, _e.si, _e.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_i,generation=18,filenames=[segments_i]
[junit4:junit4] 2> 5404 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 18[segments_i]
[junit4:junit4] 2> 5406 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@4ee4e24f main
[junit4:junit4] 2> 5410 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4ee4e24f main{StandardDirectoryReader(segments_h:61:nrt)}
[junit4:junit4] 2> 5410 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5411 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5412 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4ee4e24f main{StandardDirectoryReader(segments_h:61:nrt)}
[junit4:junit4] 2> 5413 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 28
[junit4:junit4] 2> 5421 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 5430 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc0 (1429281809586192384)]} 0 2
[junit4:junit4] 2> 5437 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc1 (1429281809594580992)]} 0 2
[junit4:junit4] 2> 5445 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc2 (1429281809601921024)]} 0 2
[junit4:junit4] 2> 5452 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc3 (1429281809610309632)]} 0 1
[junit4:junit4] 2> 5457 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc4 (1429281809615552512)]} 0 1
[junit4:junit4] 2> 5463 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc5 (1429281809621843968)]} 0 2
[junit4:junit4] 2> 5469 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc6 (1429281809628135424)]} 0 1
[junit4:junit4] 2> 5475 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc7 (1429281809634426880)]} 0 1
[junit4:junit4] 2> 5480 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc8 (1429281809639669760)]} 0 1
[junit4:junit4] 2> 5485 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc9 (1429281809645961216)]} 0 1
[junit4:junit4] 2> 5490 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5514 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_i,generation=18,filenames=[segments_i]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_j,generation=19,filenames=[_f_Lucene41_0.doc, _f_Lucene41_0.tim, _f.fdx, _f_Lucene41_0.tip, _f.nvd, segments_j, _f.si, _f.nvm, _f.fnm, _f_Lucene41_0.pos, _f.fdt]
[junit4:junit4] 2> 5514 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 19[_f_Lucene41_0.doc, _f_Lucene41_0.tim, _f.fdx, _f_Lucene41_0.tip, _f.nvd, segments_j, _f.si, _f.nvm, _f.fnm, _f_Lucene41_0.pos, _f.fdt]
[junit4:junit4] 2> 5518 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1349956b main
[junit4:junit4] 2> 5520 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1349956b main{StandardDirectoryReader(segments_j:63:nrt _f(4.3):C10)}
[junit4:junit4] 2> 5520 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5520 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5521 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1349956b main{StandardDirectoryReader(segments_j:63:nrt _f(4.3):C10)}
[junit4:junit4] 2> 5521 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 31
[junit4:junit4] 2> 5526 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=10 status=0 QTime=1
[junit4:junit4] 2> 5542 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=0&stats.field=val_pi&wt=javabin&stats=true} hits=10 status=0 QTime=11
[junit4:junit4] 2> 5549 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@bfe9e93e realtime
[junit4:junit4] 2> 5550 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809712021504)} 0 3
[junit4:junit4] 2> 5554 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5574 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_j,generation=19,filenames=[_f_Lucene41_0.doc, _f_Lucene41_0.tim, _f.fdx, _f_Lucene41_0.tip, _f.nvd, segments_j, _f.si, _f.nvm, _f.fnm, _f_Lucene41_0.pos, _f.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_k,generation=20,filenames=[segments_k]
[junit4:junit4] 2> 5574 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 20[segments_k]
[junit4:junit4] 2> 5577 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@6ba30ac9 main
[junit4:junit4] 2> 5578 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6ba30ac9 main{StandardDirectoryReader(segments_j:65:nrt)}
[junit4:junit4] 2> 5579 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5578 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5579 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6ba30ac9 main{StandardDirectoryReader(segments_j:65:nrt)}
[junit4:junit4] 2> 5580 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 26
[junit4:junit4] 2> 5586 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 5594 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc10 (1429281809757110272)]} 0 3
[junit4:junit4] 2> 5602 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc11 (1429281809766547456)]} 0 2
[junit4:junit4] 2> 5610 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc12 (1429281809774936064)]} 0 2
[junit4:junit4] 2> 5617 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc13 (1429281809783324672)]} 0 2
[junit4:junit4] 2> 5625 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc14 (1429281809791713280)]} 0 2
[junit4:junit4] 2> 5630 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5694 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_k,generation=20,filenames=[segments_k]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_l,generation=21,filenames=[_g.fdt, _g_Lucene41_0.doc, _g_Lucene41_0.tim, _g.fdx, _g_Lucene41_0.tip, _g.nvd, _g.si, _g_Lucene41_0.pos, segments_l, _g.nvm, _g.fnm]
[junit4:junit4] 2> 5695 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 21[_g.fdt, _g_Lucene41_0.doc, _g_Lucene41_0.tim, _g.fdx, _g_Lucene41_0.tip, _g.nvd, _g.si, _g_Lucene41_0.pos, segments_l, _g.nvm, _g.fnm]
[junit4:junit4] 2> 5700 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@63c60757 main
[junit4:junit4] 2> 5701 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@63c60757 main{StandardDirectoryReader(segments_l:67:nrt _g(4.3):C5)}
[junit4:junit4] 2> 5701 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5702 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5702 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@63c60757 main{StandardDirectoryReader(segments_l:67:nrt _g(4.3):C5)}
[junit4:junit4] 2> 5704 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 74
[junit4:junit4] 2> 5713 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 5720 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&rows=0&stats.field=val_pi&wt=javabin&stats=true} hits=5 status=0 QTime=1
[junit4:junit4] 2> 5729 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@930f673e realtime
[junit4:junit4] 2> 5730 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281809898668032)} 0 4
[junit4:junit4] 2> 5735 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5753 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_l,generation=21,filenames=[_g.fdt, _g_Lucene41_0.doc, _g_Lucene41_0.tim, _g.fdx, _g_Lucene41_0.tip, _g.nvd, _g.si, _g_Lucene41_0.pos, segments_l, _g.nvm, _g.fnm]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_m,generation=22,filenames=[segments_m]
[junit4:junit4] 2> 5755 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 22[segments_m]
[junit4:junit4] 2> 5757 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@915c4a08 main
[junit4:junit4] 2> 5759 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@915c4a08 main{StandardDirectoryReader(segments_l:69:nrt)}
[junit4:junit4] 2> 5759 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5759 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5760 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@915c4a08 main{StandardDirectoryReader(segments_l:69:nrt)}
[junit4:junit4] 2> 5762 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 27
[junit4:junit4] 2> 5766 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 5773 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc0 (1429281809945853952)]} 0 2
[junit4:junit4] 2> 5779 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc1 (1429281809953193984)]} 0 1
[junit4:junit4] 2> 5784 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc2 (1429281809958436864)]} 0 1
[junit4:junit4] 2> 5790 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc3 (1429281809964728320)]} 0 1
[junit4:junit4] 2> 5797 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc4 (1429281809972068352)]} 0 1
[junit4:junit4] 2> 5806 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc5 (1429281809980456960)]} 0 2
[junit4:junit4] 2> 5814 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc6 (1429281809989894144)]} 0 1
[junit4:junit4] 2> 5822 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc7 (1429281809997234176)]} 0 2
[junit4:junit4] 2> 5834 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc8 (1429281810010865664)]} 0 2
[junit4:junit4] 2> 5840 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[doc9 (1429281810017157120)]} 0 2
[junit4:junit4] 2> 5844 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5884 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_m,generation=22,filenames=[segments_m]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_n,generation=23,filenames=[_h_Lucene41_0.doc, _h_Lucene41_0.tim, _h.nvm, _h.fnm, _h.fdt, _h_Lucene41_0.tip, _h.fdx, _h.nvd, _h.si, _h_Lucene41_0.pos, segments_n]
[junit4:junit4] 2> 5884 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 23[_h_Lucene41_0.doc, _h_Lucene41_0.tim, _h.nvm, _h.fnm, _h.fdt, _h_Lucene41_0.tip, _h.fdx, _h.nvd, _h.si, _h_Lucene41_0.pos, segments_n]
[junit4:junit4] 2> 5888 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@ede1daf0 main
[junit4:junit4] 2> 5889 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ede1daf0 main{StandardDirectoryReader(segments_n:71:nrt _h(4.3):C10)}
[junit4:junit4] 2> 5889 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5889 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5890 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ede1daf0 main{StandardDirectoryReader(segments_n:71:nrt _h(4.3):C10)}
[junit4:junit4] 2> 5890 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 46
[junit4:junit4] 2> 5895 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=inStock:true&version=2&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 5901 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=inStock:false&version=2&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 5911 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&f.val_pi.stats.facet=inStock&rows=0&stats.field=val_pi&wt=javabin&stats=true} hits=10 status=0 QTime=4
[junit4:junit4] 2> 5913 T77 oas.SolrTestCaseJ4.tearDown ###Ending testStatistics
[junit4:junit4] 2> 5928 T77 oas.SolrTestCaseJ4.setUp ###Starting testAugmentFields
[junit4:junit4] 2> 5936 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@8f9589ce realtime
[junit4:junit4] 2> 5937 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281810117820416)} 0 2
[junit4:junit4] 2> 5945 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[111 (1429281810126209024)]} 0 2
[junit4:junit4] 2> 5950 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 5984 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_n,generation=23,filenames=[_h_Lucene41_0.doc, _h_Lucene41_0.tim, _h.nvm, _h.fnm, _h.fdt, _h_Lucene41_0.tip, _h.fdx, _h.nvd, _h.si, _h_Lucene41_0.pos, segments_n]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_o,generation=24,filenames=[segments_o, _i.nvm, _i.fnm, _i.fdt, _i_Lucene41_0.tip, _i.fdx, _i.nvd, _i.si, _i_Lucene41_0.pos, _i_Lucene41_0.doc, _i_Lucene41_0.tim]
[junit4:junit4] 2> 5986 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 24[segments_o, _i.nvm, _i.fnm, _i.fdt, _i_Lucene41_0.tip, _i.fdx, _i.nvd, _i.si, _i_Lucene41_0.pos, _i_Lucene41_0.doc, _i_Lucene41_0.tim]
[junit4:junit4] 2> 5994 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@dc696cda main
[junit4:junit4] 2> 5997 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@dc696cda main{StandardDirectoryReader(segments_o:75:nrt _i(4.3):C1)}
[junit4:junit4] 2> 5997 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 5997 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 5998 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@dc696cda main{StandardDirectoryReader(segments_o:75:nrt _i(4.3):C1)}
[junit4:junit4] 2> 5999 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 49
[junit4:junit4] 2> 6010 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[222 (1429281810194366464)]} 0 2
[junit4:junit4] 2> 6014 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 6054 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_o,generation=24,filenames=[segments_o, _i.nvm, _i.fnm, _i.fdt, _i_Lucene41_0.tip, _i.fdx, _i.nvd, _i.si, _i_Lucene41_0.pos, _i_Lucene41_0.doc, _i_Lucene41_0.tim]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_p,generation=25,filenames=[_i.fnm, _i.nvm, _j.fnm, _j.nvm, _j_Lucene41_0.pos, _i_Lucene41_0.pos, _j_Lucene41_0.doc, _j_Lucene41_0.tim, _i_Lucene41_0.tim, _i_Lucene41_0.doc, _j_Lucene41_0.tip, segments_p, _i_Lucene41_0.tip, _i.fdt, _j.fdt, _i.fdx, _j.fdx, _i.nvd, _j.si, _j.nvd, _i.si]
[junit4:junit4] 2> 6055 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 25[_i.fnm, _i.nvm, _j.fnm, _j.nvm, _j_Lucene41_0.pos, _i_Lucene41_0.pos, _j_Lucene41_0.doc, _j_Lucene41_0.tim, _i_Lucene41_0.tim, _i_Lucene41_0.doc, _j_Lucene41_0.tip, segments_p, _i_Lucene41_0.tip, _i.fdt, _j.fdt, _i.fdx, _j.fdx, _i.nvd, _j.si, _j.nvd, _i.si]
[junit4:junit4] 2> 6060 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@5fb18edf main
[junit4:junit4] 2> 6064 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5fb18edf main{StandardDirectoryReader(segments_p:77:nrt _i(4.3):C1 _j(4.3):C1)}
[junit4:junit4] 2> 6065 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 6066 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5fb18edf main{StandardDirectoryReader(segments_p:77:nrt _i(4.3):C1 _j(4.3):C1)}
[junit4:junit4] 2> 6067 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 6068 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 54
[junit4:junit4] 2> 6075 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,price,[docid],[explain+style%3Dnl],score,aaa:[value+v%3Daaa],ten:[value+v%3D10+t%3Dint]&version=2&wt=javabin&sort=price+asc} hits=2 status=0 QTime=3
[junit4:junit4] 2> 6077 T77 oas.SolrTestCaseJ4.tearDown ###Ending testAugmentFields
[junit4:junit4] 2> 6087 T77 oas.SolrTestCaseJ4.setUp ###Starting testBadSetup
[junit4:junit4] 2> 6087 T77 oas.SolrTestCaseJ4.tearDown ###Ending testBadSetup
[junit4:junit4] 2> 6099 T77 oas.SolrTestCaseJ4.setUp ###Starting testErrorHandling
[junit4:junit4] 2> 6113 T81 C9 oasc.SolrException.log Ignoring exception matching ignore_exception
[junit4:junit4] 2> 6114 T81 C9 REQ [collection1] webapp=/solr path=/analysis/field params={analysis.fieldtype=int&qt=/analysis/field&version=2&analysis.fieldvalue=ignore_exception&wt=javabin} status=400 QTime=11
[junit4:junit4] 2> 6123 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {} 0 4
[junit4:junit4] 2> 6126 T86 C9 oasc.SolrException.log Ignoring exception matching ignore_exception
[junit4:junit4] 2> 6134 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {} 0 0
[junit4:junit4] 2> 6135 T80 C9 oasc.SolrException.log Ignoring exception matching uniqueKey
[junit4:junit4] 2> 6137 T77 oas.SolrTestCaseJ4.tearDown ###Ending testErrorHandling
[junit4:junit4] 2> 6153 T77 oas.SolrTestCaseJ4.setUp ###Starting testPivotFacetsMissing
[junit4:junit4] 2> 6160 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@2defd15b realtime
[junit4:junit4] 2> 6161 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281810350604288)} 0 4
[junit4:junit4] 2> 6168 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 6184 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_p,generation=25,filenames=[_i.fnm, _i.nvm, _j.fnm, _j.nvm, _j_Lucene41_0.pos, _i_Lucene41_0.pos, _j_Lucene41_0.doc, _j_Lucene41_0.tim, _i_Lucene41_0.tim, _i_Lucene41_0.doc, _j_Lucene41_0.tip, segments_p, _i_Lucene41_0.tip, _i.fdt, _j.fdt, _i.fdx, _j.fdx, _i.nvd, _j.si, _j.nvd, _i.si]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_q,generation=26,filenames=[segments_q]
[junit4:junit4] 2> 6185 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 26[segments_q]
[junit4:junit4] 2> 6188 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@6cc685e0 main
[junit4:junit4] 2> 6189 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6cc685e0 main{StandardDirectoryReader(segments_p:79:nrt)}
[junit4:junit4] 2> 6189 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 6189 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 6189 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6cc685e0 main{StandardDirectoryReader(segments_p:79:nrt)}
[junit4:junit4] 2> 6192 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 24
[junit4:junit4] 2> 6197 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 6215 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1 (1429281810398838784), 2 (1429281810400935936), 3 (1429281810401984512), 4 (1429281810403033088), 5 (1429281810404081664), 6 (1429281810405130240), 7 (1429281810406178816), 8 (1429281810407227392), 9 (1429281810408275968), 10 (1429281810409324544), ... (12 adds)]} 0 13
[junit4:junit4] 2> 6220 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 6274 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_q,generation=26,filenames=[segments_q]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_r,generation=27,filenames=[_k_Lucene41_0.tip, _k.nvm, _k.fnm, segments_r, _k.fdt, _k.si, _k.fdx, _k_Lucene41_0.pos, _k.nvd, _k_Lucene41_0.doc, _k_Lucene41_0.tim]
[junit4:junit4] 2> 6275 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 27[_k_Lucene41_0.tip, _k.nvm, _k.fnm, segments_r, _k.fdt, _k.si, _k.fdx, _k_Lucene41_0.pos, _k.nvd, _k_Lucene41_0.doc, _k_Lucene41_0.tim]
[junit4:junit4] 2> 6278 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@a73c9521 main
[junit4:junit4] 2> 6280 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@a73c9521 main{StandardDirectoryReader(segments_r:81:nrt _k(4.3):C12)}
[junit4:junit4] 2> 6280 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 6280 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 6281 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a73c9521 main{StandardDirectoryReader(segments_r:81:nrt _k(4.3):C12)}
[junit4:junit4] 2> 6281 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 61
[junit4:junit4] 2> 6287 T81 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=features,memSize=4521,tindexSize=43,time=1,phase1=1,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 2> 6290 T81 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=cat,memSize=4515,tindexSize=41,time=0,phase1=0,nTerms=2,bigTerms=2,termInstances=0,uses=0}
[junit4:junit4] 2> 6294 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.mincount=0&facet=true&version=2&rows=0&facet.pivot=features,cat&facet.pivot=cat,features&facet.pivot=features,cat,inStock&wt=javabin&facet.missing=true} hits=12 status=0 QTime=8
[junit4:junit4] 2> 6305 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.mincount=0&facet=true&version=2&rows=0&fq={!tag%3Dmytag}-(features:bbb+AND+cat:a+AND+inStock:true)&facet.pivot={!ex%3Dmytag+key%3Dmykey}features,cat&wt=javabin} hits=11 status=0 QTime=4
[junit4:junit4] 2> 6307 T77 oas.SolrTestCaseJ4.tearDown ###Ending testPivotFacetsMissing
[junit4:junit4] 2> 6320 T77 oas.SolrTestCaseJ4.setUp ###Starting testStreamingRequest
[junit4:junit4] 2> 6326 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@ca5f1eda realtime
[junit4:junit4] 2> 6327 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281810526765056)} 0 3
[junit4:junit4] 2> 6333 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 6354 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_r,generation=27,filenames=[_k_Lucene41_0.tip, _k.nvm, _k.fnm, segments_r, _k.fdt, _k.si, _k.fdx, _k_Lucene41_0.pos, _k.nvd, _k_Lucene41_0.doc, _k_Lucene41_0.tim]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_s,generation=28,filenames=[segments_s]
[junit4:junit4] 2> 6354 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 28[segments_s]
[junit4:junit4] 2> 6357 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@83b96942 main
[junit4:junit4] 2> 6358 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@83b96942 main{StandardDirectoryReader(segments_r:83:nrt)}
[junit4:junit4] 2> 6358 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 6358 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 6359 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@83b96942 main{StandardDirectoryReader(segments_r:83:nrt)}
[junit4:junit4] 2> 6360 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 27
[junit4:junit4] 2> 6366 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 6379 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 6444 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_s,generation=28,filenames=[segments_s]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_t,generation=29,filenames=[_l.nvm, _l.fnm, _l.fdt, segments_t, _l.si, _l_Lucene41_0.pos, _l.fdx, _l.nvd, _l_Lucene41_0.doc, _l_Lucene41_0.tim, _l_Lucene41_0.tip]
[junit4:junit4] 2> 6445 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 29[_l.nvm, _l.fnm, _l.fdt, segments_t, _l.si, _l_Lucene41_0.pos, _l.fdx, _l.nvd, _l_Lucene41_0.doc, _l_Lucene41_0.tim, _l_Lucene41_0.tip]
[junit4:junit4] 2> 6450 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@2bd60eb2 main
[junit4:junit4] 2> 6452 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2bd60eb2 main{StandardDirectoryReader(segments_t:85:nrt _l(4.3):C10)}
[junit4:junit4] 2> 6452 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 6452 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 6453 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2bd60eb2 main{StandardDirectoryReader(segments_t:85:nrt _l(4.3):C10)}
[junit4:junit4] 2> 6453 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {add=[0 (1429281810576048128), 1 (1429281810578145280), 2 (1429281810579193856), 3 (1429281810579193857), 4 (1429281810580242432), 5 (1429281810580242433), 6 (1429281810581291008), 7 (1429281810581291009), 8 (1429281810582339584), 9 (1429281810582339585)],commit=} 0 81
[junit4:junit4] 2> 6459 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,score,_docid_&version=2&wt=javabin} hits=10 status=0 QTime=1
[junit4:junit4] 2> 6466 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,score,_docid_&version=2&wt=javabin} hits=10 status=0 QTime=1
[junit4:junit4] 2> 6731 T77 oas.SolrTestCaseJ4.tearDown ###Ending testStreamingRequest
[junit4:junit4] 2> 6746 T77 oas.SolrTestCaseJ4.setUp ###Starting testLukeHandler
[junit4:junit4] 2> 6756 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@7d086f5a realtime
[junit4:junit4] 2> 6757 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429281810976604160)} 0 3
[junit4:junit4] 2> 21757 T90 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=false,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 21774 T90 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_t,generation=29,filenames=[_l.nvm, _l.fnm, _l.fdt, segments_t, _l.si, _l_Lucene41_0.pos, _l.fdx, _l.nvd, _l_Lucene41_0.doc, _l_Lucene41_0.tim, _l_Lucene41_0.tip]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_u,generation=30,filenames=[segments_u]
[junit4:junit4] 2> 21774 T90 oasc.SolrDeletionPolicy.updateCommits newest commit = 30[segments_u]
[junit4:junit4] 2> 21776 T90 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 207015 T77 oas.SolrTestCaseJ4.tearDown ###Ending testLukeHandler
[junit4:junit4] 2> 207017 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[ID0 (1429282020966531072)]} 0 2
[junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrExampleJettyTest -Dtests.method=testLukeHandler -Dtests.seed=C6B0C0030A65333F -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=fr_FR -Dtests.timezone=CAT -Dtests.file.encoding=ISO-8859-1
[junit4:junit4] ERROR 200s J1 | SolrExampleJettyTest.testLukeHandler <<<
[junit4:junit4] > Throwable #1: org.apache.solr.client.solrj.SolrServerException: IOException occured when talking to server at: https://127.0.0.1:58580/solr
[junit4:junit4] > at __randomizedtesting.SeedInfo.seed([C6B0C0030A65333F:2D0D1A181423457]:0)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:416)
[junit4:junit4] > at org.apache.solr.client.solrj.impl.HttpSolrServer.request(HttpSolrServer.java:181)
[junit4:junit4] > at org.apache.solr.client.solrj.request.AbstractUpdateRequest.process(AbstractUpdateRequest.java:117)
[junit4:junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:116)
[junit4:junit4] > at org.apache.solr.client.solrj.SolrServer.add(SolrServer.java:102)
[junit4:junit4] > at org.apache.solr.client.solrj.SolrExampleTests.testLukeHandler(SolrExampleTests.java:770)
[junit4:junit4] > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
[junit4:junit4] > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:88)
[junit4:junit4] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:55)
[junit4:junit4] > at java.lang.reflect.Method.invoke(Method.java:613)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] > at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50)
[junit4:junit4] > at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51)
[junit4:junit4] > at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] > at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49)
[junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] > at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53)
[junit4:junit4] > at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46)
[junit4:junit4] > at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] > at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43)
[junit4:junit4] > at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
[junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70)
[junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
[junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358)
[junit4:junit4] > at java.lang.Thread.run(Thread.java:780)
[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:353)
[junit4:junit4] > ... 45 more
[junit4:junit4] 2> 207051 T77 oas.SolrTestCaseJ4.setUp ###Starting testChineseDefaults
[junit4:junit4] 2> 207071 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@5d0f9733 realtime
[junit4:junit4] 2> 207072 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282021012668416)} 0 12
[junit4:junit4] 2> 207076 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 207086 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_u,generation=30,filenames=[segments_u]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_v,generation=31,filenames=[segments_v]
[junit4:junit4] 2> 207087 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 31[segments_v]
[junit4:junit4] 2> 207088 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@57e38055 main
[junit4:junit4] 2> 207088 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@57e38055 main{StandardDirectoryReader(segments_u:91:nrt)}
[junit4:junit4] 2> 207088 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 207089 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 207089 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@57e38055 main{StandardDirectoryReader(segments_u:91:nrt)}
[junit4:junit4] 2> 207090 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 14
[junit4:junit4] 2> 207094 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 207099 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 207176 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_v,generation=31,filenames=[segments_v]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_w,generation=32,filenames=[_n.si, _n_Lucene41_0.pos, _n.nvm, _n.fnm, _n.fdt, segments_w, _n_Lucene41_0.doc, _n_Lucene41_0.tim, _n.fdx, _n.nvd, _n_Lucene41_0.tip]
[junit4:junit4] 2> 207177 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 32[_n.si, _n_Lucene41_0.pos, _n.nvm, _n.fnm, _n.fdt, segments_w, _n_Lucene41_0.doc, _n_Lucene41_0.tim, _n.fdx, _n.nvd, _n_Lucene41_0.tip]
[junit4:junit4] 2> 207181 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@edb20bbc main
[junit4:junit4] 2> 207182 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@edb20bbc main{StandardDirectoryReader(segments_w:93:nrt _n(4.3):C1)}
[junit4:junit4] 2> 207182 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 207182 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 207182 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@edb20bbc main{StandardDirectoryReader(segments_w:93:nrt _n(4.3):C1)}
[junit4:junit4] 2> 207183 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {add=[42 (1429282021052514304)],commit=} 0 85
[junit4:junit4] 2> 207188 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=????&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 207189 T77 oas.SolrTestCaseJ4.tearDown ###Ending testChineseDefaults
[junit4:junit4] 2> 207200 T77 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithinOnDelete
[junit4:junit4] 2> 207205 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3b2d86ea realtime
[junit4:junit4] 2> 207205 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282021162614784)} 0 2
[junit4:junit4] 2> 207209 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 207236 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_w,generation=32,filenames=[_n.si, _n_Lucene41_0.pos, _n.nvm, _n.fnm, _n.fdt, segments_w, _n_Lucene41_0.doc, _n_Lucene41_0.tim, _n.fdx, _n.nvd, _n_Lucene41_0.tip]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_x,generation=33,filenames=[segments_x]
[junit4:junit4] 2> 207237 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 33[segments_x]
[junit4:junit4] 2> 207240 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@eb55efc4 main
[junit4:junit4] 2> 207241 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@eb55efc4 main{StandardDirectoryReader(segments_w:95:nrt)}
[junit4:junit4] 2> 207241 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 207241 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 207242 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@eb55efc4 main{StandardDirectoryReader(segments_w:95:nrt)}
[junit4:junit4] 2> 207243 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 34
[junit4:junit4] 2> 207246 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 207253 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[id3 (1429282021211897856)]} 0 3
[junit4:junit4] 2> 207256 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 207296 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_x,generation=33,filenames=[segments_x]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_y,generation=34,filenames=[_o.si, _o_Lucene41_0.pos, _o.nvm, _o.fnm, _o.fdt, _o_Lucene41_0.doc, _o_Lucene41_0.tim, segments_y, _o.fdx, _o_Lucene41_0.tip, _o.nvd]
[junit4:junit4] 2> 207297 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 34[_o.si, _o_Lucene41_0.pos, _o.nvm, _o.fnm, _o.fdt, _o_Lucene41_0.doc, _o_Lucene41_0.tim, segments_y, _o.fdx, _o_Lucene41_0.tip, _o.nvd]
[junit4:junit4] 2> 207299 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@de7e1abf main
[junit4:junit4] 2> 207300 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@de7e1abf main{StandardDirectoryReader(segments_y:97:nrt _o(4.3):C1)}
[junit4:junit4] 2> 207300 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 207300 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 207301 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@de7e1abf main{StandardDirectoryReader(segments_y:97:nrt _o(4.3):C1)}
[junit4:junit4] 2> 207301 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 45
[junit4:junit4] 2> 207305 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 207310 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {delete=[id3 (-1429282021273763840)]} 0 1
[junit4:junit4] 2> 207314 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 207569 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 207823 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 208077 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 208310 T91 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4:junit4] 2> 208311 T91 oass.SolrIndexSearcher.<init> Opening Searcher@5d3512d7 main
[junit4:junit4] 2> 208311 T91 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208311 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5d3512d7 main{StandardDirectoryReader(segments_y:99:nrt)}
[junit4:junit4] 2> 208312 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208312 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5d3512d7 main{StandardDirectoryReader(segments_y:99:nrt)}
[junit4:junit4] 2> 208331 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=id:id3&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 208333 T77 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithinOnDelete
[junit4:junit4] 2> 208343 T77 oas.SolrTestCaseJ4.setUp ###Starting testMultiContentStreamRequest
[junit4:junit4] 2> 208347 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282022361137152)} 0 1
[junit4:junit4] 2> 208350 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208376 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_y,generation=34,filenames=[_o.si, _o_Lucene41_0.pos, _o.nvm, _o.fnm, _o.fdt, _o_Lucene41_0.doc, _o_Lucene41_0.tim, segments_y, _o.fdx, _o_Lucene41_0.tip, _o.nvd]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_z,generation=35,filenames=[segments_z]
[junit4:junit4] 2> 208377 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 35[segments_z]
[junit4:junit4] 2> 208379 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@72c1fd44 main
[junit4:junit4] 2> 208380 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@72c1fd44 main{StandardDirectoryReader(segments_y:99:nrt)}
[junit4:junit4] 2> 208380 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208380 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208380 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@72c1fd44 main{StandardDirectoryReader(segments_y:99:nrt)}
[junit4:junit4] 2> 208381 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 31
[junit4:junit4] 2> 208384 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 208440 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208506 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_z,generation=35,filenames=[segments_z]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_10,generation=36,filenames=[_p.si, _p_Lucene41_0.pos, _p_Lucene41_0.pay, _p_Lucene41_0.doc, _p_Lucene41_0.tim, _p.nvm, _p.fnm, _p.fdt, _p_Lucene41_0.tip, _p.fdx, segments_10, _p.nvd]
[junit4:junit4] 2> 208507 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 36[_p.si, _p_Lucene41_0.pos, _p_Lucene41_0.pay, _p_Lucene41_0.doc, _p_Lucene41_0.tim, _p.nvm, _p.fnm, _p.fdt, _p_Lucene41_0.tip, _p.fdx, segments_10, _p.nvd]
[junit4:junit4] 2> 208510 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@470d0b99 main
[junit4:junit4] 2> 208511 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@470d0b99 main{StandardDirectoryReader(segments_10:101:nrt _p(4.3):C5)}
[junit4:junit4] 2> 208511 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208511 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208512 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@470d0b99 main{StandardDirectoryReader(segments_10:101:nrt _p(4.3):C5)}
[junit4:junit4] 2> 208512 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&a=?&commit=true&version=2&waitSearcher=true&echoParams=ALL&wt=javabin} {add=[SP2514N (1429282022438731776), 6H500F0 (1429282022446071808), TWINX2048-3200PRO (1429282022450266112), VS1GB400C3 (1429282022455508992), VDBDB1A16 (1429282022457606144)],commit=} 0 94
[junit4:junit4] 2> 208516 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=5 status=0 QTime=0
[junit4:junit4] 2> 208520 T77 oas.SolrTestCaseJ4.tearDown ###Ending testMultiContentStreamRequest
[junit4:junit4] 2> 208532 T77 oas.SolrTestCaseJ4.setUp ###Starting testAddDelete
[junit4:junit4] 2> 208536 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3f739ebc realtime
[junit4:junit4] 2> 208537 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282022559318016)} 0 2
[junit4:junit4] 2> 208541 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 & 222 (1429282022564560896)]} 0 1
[junit4:junit4] 2> 208546 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208576 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_10,generation=36,filenames=[_p.si, _p_Lucene41_0.pos, _p_Lucene41_0.pay, _p_Lucene41_0.doc, _p_Lucene41_0.tim, _p.nvm, _p.fnm, _p.fdt, _p_Lucene41_0.tip, _p.fdx, segments_10, _p.nvd]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_11,generation=37,filenames=[_q.si, _q_Lucene41_0.doc, _q_Lucene41_0.tim, _q.fnm, _q.fdt, _q_Lucene41_0.tip, _q.fdx, segments_11]
[junit4:junit4] 2> 208577 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 37[_q.si, _q_Lucene41_0.doc, _q_Lucene41_0.tim, _q.fnm, _q.fdt, _q_Lucene41_0.tip, _q.fdx, segments_11]
[junit4:junit4] 2> 208580 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@9c77a25c main
[junit4:junit4] 2> 208581 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@9c77a25c main{StandardDirectoryReader(segments_11:105:nrt _q(4.3):C1)}
[junit4:junit4] 2> 208581 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208581 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208582 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9c77a25c main{StandardDirectoryReader(segments_11:105:nrt _q(4.3):C1)}
[junit4:junit4] 2> 208583 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 38
[junit4:junit4] 2> 208586 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 208590 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {delete=[0 & 222 (-1429282022616989696)]} 0 0
[junit4:junit4] 2> 208594 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208636 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_11,generation=37,filenames=[_q.si, _q_Lucene41_0.doc, _q_Lucene41_0.tim, _q.fnm, _q.fdt, _q_Lucene41_0.tip, _q.fdx, segments_11]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_12,generation=38,filenames=[segments_12]
[junit4:junit4] 2> 208637 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 38[segments_12]
[junit4:junit4] 2> 208638 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@ea2cc27a main
[junit4:junit4] 2> 208639 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ea2cc27a main{StandardDirectoryReader(segments_12:107:nrt)}
[junit4:junit4] 2> 208639 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208639 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208640 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ea2cc27a main{StandardDirectoryReader(segments_12:107:nrt)}
[junit4:junit4] 2> 208640 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 46
[junit4:junit4] 2> 208644 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 208649 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 & 222 (1429282022677807104)]} 0 1
[junit4:junit4] 2> 208653 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208706 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_12,generation=38,filenames=[segments_12]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_13,generation=39,filenames=[_r.si, segments_13, _r_Lucene41_0.doc, _r_Lucene41_0.tim, _r_Lucene41_0.tip, _r.fnm, _r.fdt, _r.fdx]
[junit4:junit4] 2> 208707 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 39[_r.si, segments_13, _r_Lucene41_0.doc, _r_Lucene41_0.tim, _r_Lucene41_0.tip, _r.fnm, _r.fdt, _r.fdx]
[junit4:junit4] 2> 208709 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@bf9da6c5 main
[junit4:junit4] 2> 208709 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@bf9da6c5 main{StandardDirectoryReader(segments_13:109:nrt _r(4.3):C1)}
[junit4:junit4] 2> 208709 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208710 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208710 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bf9da6c5 main{StandardDirectoryReader(segments_13:109:nrt _r(4.3):C1)}
[junit4:junit4] 2> 208710 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 57
[junit4:junit4] 2> 208714 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 208719 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3f4ffc53 realtime
[junit4:junit4] 2> 208720 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=id:"0\ \&\ 222" (-1429282022751207424)} 0 2
[junit4:junit4] 2> 208724 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208756 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_13,generation=39,filenames=[_r.si, segments_13, _r_Lucene41_0.doc, _r_Lucene41_0.tim, _r_Lucene41_0.tip, _r.fnm, _r.fdt, _r.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_14,generation=40,filenames=[segments_14]
[junit4:junit4] 2> 208757 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 40[segments_14]
[junit4:junit4] 2> 208758 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@b57bcf1f main
[junit4:junit4] 2> 208759 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@b57bcf1f main{StandardDirectoryReader(segments_13:111:nrt)}
[junit4:junit4] 2> 208759 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208759 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208759 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b57bcf1f main{StandardDirectoryReader(segments_13:111:nrt)}
[junit4:junit4] 2> 208760 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 36
[junit4:junit4] 2> 208764 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 208769 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[0 & 222 (1429282022803636224)]} 0 2
[junit4:junit4] 2> 208772 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1 & 222 (1429282022807830528)]} 0 0
[junit4:junit4] 2> 208776 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[2 & 222 (1429282022812024832)]} 0 0
[junit4:junit4] 2> 208780 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208826 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_14,generation=40,filenames=[segments_14]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_15,generation=41,filenames=[_s.si, _s.fdx, segments_15, _s_Lucene41_0.doc, _s_Lucene41_0.tim, _s_Lucene41_0.tip, _s.fnm, _s.fdt]
[junit4:junit4] 2> 208827 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 41[_s.si, _s.fdx, segments_15, _s_Lucene41_0.doc, _s_Lucene41_0.tim, _s_Lucene41_0.tip, _s.fnm, _s.fdt]
[junit4:junit4] 2> 208829 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@998bc621 main
[junit4:junit4] 2> 208829 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@998bc621 main{StandardDirectoryReader(segments_15:113:nrt _s(4.3):C3)}
[junit4:junit4] 2> 208829 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208830 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208830 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@998bc621 main{StandardDirectoryReader(segments_15:113:nrt _s(4.3):C3)}
[junit4:junit4] 2> 208831 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 51
[junit4:junit4] 2> 208834 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=3 status=0 QTime=0
[junit4:junit4] 2> 208839 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {delete=[0 & 222 (-1429282022877036544), 1 & 222 (-1429282022877036545), 2 & 222 (-1429282022877036546)]} 0 1
[junit4:junit4] 2> 208842 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208866 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_15,generation=41,filenames=[_s.si, _s.fdx, segments_15, _s_Lucene41_0.doc, _s_Lucene41_0.tim, _s_Lucene41_0.tip, _s.fnm, _s.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_16,generation=42,filenames=[segments_16]
[junit4:junit4] 2> 208867 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 42[segments_16]
[junit4:junit4] 2> 208868 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@a3636cae main
[junit4:junit4] 2> 208869 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@a3636cae main{StandardDirectoryReader(segments_16:115:nrt)}
[junit4:junit4] 2> 208869 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208869 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208870 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a3636cae main{StandardDirectoryReader(segments_16:115:nrt)}
[junit4:junit4] 2> 208871 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 29
[junit4:junit4] 2> 208874 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 208875 T77 oas.SolrTestCaseJ4.tearDown ###Ending testAddDelete
[junit4:junit4] 2> 208882 T77 oas.SolrTestCaseJ4.setUp ###Starting testGetEmptyResults
[junit4:junit4] 2> 208885 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282022926319616)} 0 1
[junit4:junit4] 2> 208889 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208916 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_16,generation=42,filenames=[segments_16]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_17,generation=43,filenames=[segments_17]
[junit4:junit4] 2> 208917 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 43[segments_17]
[junit4:junit4] 2> 208917 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@6c537eee main
[junit4:junit4] 2> 208918 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6c537eee main{StandardDirectoryReader(segments_16:115:nrt)}
[junit4:junit4] 2> 208918 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208918 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208919 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6c537eee main{StandardDirectoryReader(segments_16:115:nrt)}
[junit4:junit4] 2> 208919 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 30
[junit4:junit4] 2> 208924 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[id1 (1429282022966165504)]} 0 2
[junit4:junit4] 2> 208928 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[id2 (1429282022970359808)]} 0 1
[junit4:junit4] 2> 208931 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 208956 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_17,generation=43,filenames=[segments_17]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_18,generation=44,filenames=[_t_Lucene41_0.pos, _t.fdx, _t.nvd, _t_Lucene41_0.doc, _t_Lucene41_0.tim, segments_18, _t_Lucene41_0.tip, _t.nvm, _t.fnm, _t.fdt, _t.si]
[junit4:junit4] 2> 208957 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 44[_t_Lucene41_0.pos, _t.fdx, _t.nvd, _t_Lucene41_0.doc, _t_Lucene41_0.tim, segments_18, _t_Lucene41_0.tip, _t.nvm, _t.fnm, _t.fdt, _t.si]
[junit4:junit4] 2> 208959 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@7be30bf9 main
[junit4:junit4] 2> 208960 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7be30bf9 main{StandardDirectoryReader(segments_18:117:nrt _t(4.3):C2)}
[junit4:junit4] 2> 208960 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 208960 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 208961 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7be30bf9 main{StandardDirectoryReader(segments_18:117:nrt _t(4.3):C2)}
[junit4:junit4] 2> 208961 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 30
[junit4:junit4] 2> 208964 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=foofoofoo&version=2&wt=javabin} hits=2 status=0 QTime=0
[junit4:junit4] 2> 208965 T77 oas.SolrTestCaseJ4.tearDown ###Ending testGetEmptyResults
[junit4:junit4] 2> 208973 T77 oas.SolrTestCaseJ4.setUp ###Starting testRealtimeGet
[junit4:junit4] 2> 208976 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1aef8464 realtime
[junit4:junit4] 2> 208977 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282023020691456)} 0 2
[junit4:junit4] 2> 208981 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[DOCID (1429282023025934336)]} 0 1
[junit4:junit4] 2> 208984 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209006 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_18,generation=44,filenames=[_t_Lucene41_0.pos, _t.fdx, _t.nvd, _t_Lucene41_0.doc, _t_Lucene41_0.tim, segments_18, _t_Lucene41_0.tip, _t.nvm, _t.fnm, _t.fdt, _t.si]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_19,generation=45,filenames=[_u.fdx, _u_Lucene41_0.doc, _u_Lucene41_0.tim, _u.nvd, _u_Lucene41_0.tip, segments_19, _u.nvm, _u.fnm, _u.fdt, _u.si, _u_Lucene41_0.pos]
[junit4:junit4] 2> 209007 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 45[_u.fdx, _u_Lucene41_0.doc, _u_Lucene41_0.tim, _u.nvd, _u_Lucene41_0.tip, segments_19, _u.nvm, _u.fnm, _u.fdt, _u.si, _u_Lucene41_0.pos]
[junit4:junit4] 2> 209010 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@89da2e6 main
[junit4:junit4] 2> 209011 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@89da2e6 main{StandardDirectoryReader(segments_19:121:nrt _u(4.3):C1)}
[junit4:junit4] 2> 209011 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209011 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209012 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@89da2e6 main{StandardDirectoryReader(segments_19:121:nrt _u(4.3):C1)}
[junit4:junit4] 2> 209012 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 28
[junit4:junit4] 2> 209016 T80 C9 REQ [collection1] webapp=/solr path=/get params={qt=/get&fl=id,name,aaa:[value+v%3Daaa]&version=2&id=DOCID&wt=javabin} status=0 QTime=0
[junit4:junit4] 2> 209020 T85 C9 REQ [collection1] webapp=/solr path=/get params={qt=/get&fl=id,name,aaa:[value+v%3Daaa]&version=2.2&id=DOCID&wt=xml} status=0 QTime=1
[junit4:junit4] 2> 209021 T77 oas.SolrTestCaseJ4.tearDown ###Ending testRealtimeGet
[junit4:junit4] 2> 209029 T77 oas.SolrTestCaseJ4.setUp ###Starting testUpdateField
[junit4:junit4] 2> 209034 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@330a5fee realtime
[junit4:junit4] 2> 209034 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282023080460288)} 0 2
[junit4:junit4] 2> 209038 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209067 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_19,generation=45,filenames=[_u.fdx, _u_Lucene41_0.doc, _u_Lucene41_0.tim, _u.nvd, _u_Lucene41_0.tip, segments_19, _u.nvm, _u.fnm, _u.fdt, _u.si, _u_Lucene41_0.pos]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1a,generation=46,filenames=[segments_1a]
[junit4:junit4] 2> 209068 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 46[segments_1a]
[junit4:junit4] 2> 209070 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@20243923 main
[junit4:junit4] 2> 209071 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@20243923 main{StandardDirectoryReader(segments_19:123:nrt)}
[junit4:junit4] 2> 209072 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209071 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209072 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@20243923 main{StandardDirectoryReader(segments_19:123:nrt)}
[junit4:junit4] 2> 209073 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 35
[junit4:junit4] 2> 209079 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[unique (1429282023127646208)]} 0 2
[junit4:junit4] 2> 209083 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209106 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1a,generation=46,filenames=[segments_1a]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1b,generation=47,filenames=[segments_1b, _v_Lucene41_0.doc, _v_Lucene41_0.tim, _v.fdx, _v_Lucene41_0.tip, _v.nvd, _v.si, _v_Lucene41_0.pos, _v.nvm, _v.fnm, _v.fdt]
[junit4:junit4] 2> 209107 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 47[segments_1b, _v_Lucene41_0.doc, _v_Lucene41_0.tim, _v.fdx, _v_Lucene41_0.tip, _v.nvd, _v.si, _v_Lucene41_0.pos, _v.nvm, _v.fnm, _v.fdt]
[junit4:junit4] 2> 209110 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@881ee588 main
[junit4:junit4] 2> 209111 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@881ee588 main{StandardDirectoryReader(segments_1b:125:nrt _v(4.3):C1)}
[junit4:junit4] 2> 209111 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209111 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209111 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@881ee588 main{StandardDirectoryReader(segments_1b:125:nrt _v(4.3):C1)}
[junit4:junit4] 2> 209112 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 29
[junit4:junit4] 2> 209116 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,price_f,name,_version_&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 209120 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {} 0 0
[junit4:junit4] 2> 209126 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[unique (1429282023177977856)]} 0 2
[junit4:junit4] 2> 209130 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209156 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1b,generation=47,filenames=[segments_1b, _v_Lucene41_0.doc, _v_Lucene41_0.tim, _v.fdx, _v_Lucene41_0.tip, _v.nvd, _v.si, _v_Lucene41_0.pos, _v.nvm, _v.fnm, _v.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1c,generation=48,filenames=[_w.fdt, _w_Lucene41_0.doc, _w_Lucene41_0.tim, segments_1c, _w.fdx, _w_Lucene41_0.tip, _w.nvd, _w.si, _w_Lucene41_0.pos, _w.nvm, _w.fnm]
[junit4:junit4] 2> 209157 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 48[_w.fdt, _w_Lucene41_0.doc, _w_Lucene41_0.tim, segments_1c, _w.fdx, _w_Lucene41_0.tip, _w.nvd, _w.si, _w_Lucene41_0.pos, _w.nvm, _w.fnm]
[junit4:junit4] 2> 209161 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@3f655b49 main
[junit4:junit4] 2> 209161 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3f655b49 main{StandardDirectoryReader(segments_1c:129:nrt _w(4.3):C1)}
[junit4:junit4] 2> 209161 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209162 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209162 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3f655b49 main{StandardDirectoryReader(segments_1c:129:nrt _w(4.3):C1)}
[junit4:junit4] 2> 209163 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 33
[junit4:junit4] 2> 209166 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,price_f,name,_version_&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 209172 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[unique (1429282023225163776)]} 0 2
[junit4:junit4] 2> 209176 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209206 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1c,generation=48,filenames=[_w.fdt, _w_Lucene41_0.doc, _w_Lucene41_0.tim, segments_1c, _w.fdx, _w_Lucene41_0.tip, _w.nvd, _w.si, _w_Lucene41_0.pos, _w.nvm, _w.fnm]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1d,generation=49,filenames=[_x.nvm, _x.fnm, _x_Lucene41_0.doc, _x_Lucene41_0.tim, _x.fdt, segments_1d, _x_Lucene41_0.tip, _x.fdx, _x.nvd, _x.si, _x_Lucene41_0.pos]
[junit4:junit4] 2> 209207 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 49[_x.nvm, _x.fnm, _x_Lucene41_0.doc, _x_Lucene41_0.tim, _x.fdt, segments_1d, _x_Lucene41_0.tip, _x.fdx, _x.nvd, _x.si, _x_Lucene41_0.pos]
[junit4:junit4] 2> 209210 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@e730bef8 main
[junit4:junit4] 2> 209211 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@e730bef8 main{StandardDirectoryReader(segments_1d:133:nrt _x(4.3):C1)}
[junit4:junit4] 2> 209211 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209211 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209211 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e730bef8 main{StandardDirectoryReader(segments_1d:133:nrt _x(4.3):C1)}
[junit4:junit4] 2> 209212 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 36
[junit4:junit4] 2> 209216 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&fl=id,price_f,name,_version_&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 209217 T77 oas.SolrTestCaseJ4.tearDown ###Ending testUpdateField
[junit4:junit4] 2> 209228 T77 oas.SolrTestCaseJ4.setUp ###Starting testFaceting
[junit4:junit4] 2> 209233 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1d44eb3 realtime
[junit4:junit4] 2> 209234 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282023290175488)} 0 2
[junit4:junit4] 2> 209237 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209256 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1d,generation=49,filenames=[_x.nvm, _x.fnm, _x_Lucene41_0.doc, _x_Lucene41_0.tim, _x.fdt, segments_1d, _x_Lucene41_0.tip, _x.fdx, _x.nvd, _x.si, _x_Lucene41_0.pos]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1e,generation=50,filenames=[segments_1e]
[junit4:junit4] 2> 209257 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 50[segments_1e]
[junit4:junit4] 2> 209258 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@e0e158bc main
[junit4:junit4] 2> 209259 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@e0e158bc main{StandardDirectoryReader(segments_1d:135:nrt)}
[junit4:junit4] 2> 209259 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209259 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209260 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e0e158bc main{StandardDirectoryReader(segments_1d:135:nrt)}
[junit4:junit4] 2> 209261 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 24
[junit4:junit4] 2> 209264 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 209275 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1 (1429282023327924224), 2 (1429282023330021376), 3 (1429282023330021377), 4 (1429282023331069952), 5 (1429282023332118528), 6 (1429282023332118529), 7 (1429282023333167104), 8 (1429282023333167105), 9 (1429282023334215680), 10 (1429282023335264256)]} 0 7
[junit4:junit4] 2> 209279 T86 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209316 T86 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1e,generation=50,filenames=[segments_1e]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1f,generation=51,filenames=[_y.nvm, _y.fnm, _y.fdt, _y_Lucene41_0.tip, segments_1f, _y.fdx, _y.nvd, _y.si, _y_Lucene41_0.pos, _y_Lucene41_0.doc, _y_Lucene41_0.tim]
[junit4:junit4] 2> 209317 T86 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 51[_y.nvm, _y.fnm, _y.fdt, _y_Lucene41_0.tip, segments_1f, _y.fdx, _y.nvd, _y.si, _y_Lucene41_0.pos, _y_Lucene41_0.doc, _y_Lucene41_0.tim]
[junit4:junit4] 2> 209319 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@f7f70ffa main
[junit4:junit4] 2> 209320 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@f7f70ffa main{StandardDirectoryReader(segments_1f:137:nrt _y(4.3):C10)}
[junit4:junit4] 2> 209320 T86 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209320 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209321 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@f7f70ffa main{StandardDirectoryReader(segments_1f:137:nrt _y(4.3):C10)}
[junit4:junit4] 2> 209321 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 42
[junit4:junit4] 2> 209325 T80 C9 oasr.UnInvertedField.<init> UnInverted multi-valued field {field=features,memSize=4564,tindexSize=44,time=0,phase1=0,nTerms=4,bigTerms=2,termInstances=4,uses=0}
[junit4:junit4] 2> 209326 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.field=features&facet.mincount=0&facet=true&version=2&rows=0&wt=javabin} hits=10 status=0 QTime=2
[junit4:junit4] 2> 209332 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.field=features&facet.mincount=0&facet=true&version=2&rows=0&fq=features:two&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 209336 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.field=features&facet.mincount=4&facet=true&version=2&rows=0&fq=features:two&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 209340 T81 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&facet.field=features&facet.mincount=-1&facet=true&version=2&rows=0&fq=features:two&wt=javabin} hits=5 status=0 QTime=1
[junit4:junit4] 2> 209341 T77 oas.SolrTestCaseJ4.tearDown ###Ending testFaceting
[junit4:junit4] 2> 209350 T77 oas.SolrTestCaseJ4.setUp ###Starting testUpdateMultiValuedField
[junit4:junit4] 2> 209355 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[123 (1429282023417053184)]} 0 2
[junit4:junit4] 2> 209359 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209386 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1f,generation=51,filenames=[_y.nvm, _y.fnm, _y.fdt, _y_Lucene41_0.tip, segments_1f, _y.fdx, _y.nvd, _y.si, _y_Lucene41_0.pos, _y_Lucene41_0.doc, _y_Lucene41_0.tim]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1g,generation=52,filenames=[_z_Lucene41_0.tip, _y_Lucene41_0.tip, _y.fdt, _z.fdt, _y.fdx, _z.fdx, _y.nvd, _z.si, _y.si, _y.fnm, _y.nvm, _z.fnm, segments_1g, _y_Lucene41_0.pos, _z_Lucene41_0.doc, _z_Lucene41_0.tim, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209387 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 52[_z_Lucene41_0.tip, _y_Lucene41_0.tip, _y.fdt, _z.fdt, _y.fdx, _z.fdx, _y.nvd, _z.si, _y.si, _y.fnm, _y.nvm, _z.fnm, segments_1g, _y_Lucene41_0.pos, _z_Lucene41_0.doc, _z_Lucene41_0.tim, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209389 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@299374b7 main
[junit4:junit4] 2> 209390 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@299374b7 main{StandardDirectoryReader(segments_1g:139:nrt _y(4.3):C10 _z(4.3):C1)}
[junit4:junit4] 2> 209390 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209390 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209391 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@299374b7 main{StandardDirectoryReader(segments_1g:139:nrt _y(4.3):C10 _z(4.3):C1)}
[junit4:junit4] 2> 209391 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 33
[junit4:junit4] 2> 209395 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=id:123&version=2&wt=javabin} hits=1 status=0 QTime=0
[junit4:junit4] 2> 209401 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[123 (1429282023465287680)]} 0 2
[junit4:junit4] 2> 209404 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209426 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1g,generation=52,filenames=[_z_Lucene41_0.tip, _y_Lucene41_0.tip, _y.fdt, _z.fdt, _y.fdx, _z.fdx, _y.nvd, _z.si, _y.si, _y.fnm, _y.nvm, _z.fnm, segments_1g, _y_Lucene41_0.pos, _z_Lucene41_0.doc, _z_Lucene41_0.tim, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1h,generation=53,filenames=[_y_Lucene41_0.tip, _y.fdt, _10.si, _y.fdx, _10.fdt, _y.nvd, _10.fdx, _y.si, _y.fnm, _y.nvm, _10.fnm, segments_1h, _10_Lucene41_0.doc, _10_Lucene41_0.tim, _y_Lucene41_0.pos, _10_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209427 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 53[_y_Lucene41_0.tip, _y.fdt, _10.si, _y.fdx, _10.fdt, _y.nvd, _10.fdx, _y.si, _y.fnm, _y.nvm, _10.fnm, segments_1h, _10_Lucene41_0.doc, _10_Lucene41_0.tim, _y_Lucene41_0.pos, _10_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209430 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@11e97611 main
[junit4:junit4] 2> 209430 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@11e97611 main{StandardDirectoryReader(segments_1h:143:nrt _y(4.3):C10 _10(4.3):C1)}
[junit4:junit4] 2> 209430 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209431 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209431 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11e97611 main{StandardDirectoryReader(segments_1h:143:nrt _y(4.3):C10 _10(4.3):C1)}
[junit4:junit4] 2> 209432 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 28
[junit4:junit4] 2> 209436 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=id:123&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 209441 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[123 (1429282023508279296)]} 0 2
[junit4:junit4] 2> 209444 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209476 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1h,generation=53,filenames=[_y_Lucene41_0.tip, _y.fdt, _10.si, _y.fdx, _10.fdt, _y.nvd, _10.fdx, _y.si, _y.fnm, _y.nvm, _10.fnm, segments_1h, _10_Lucene41_0.doc, _10_Lucene41_0.tim, _y_Lucene41_0.pos, _10_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1i,generation=54,filenames=[_y_Lucene41_0.tip, _y.fdt, _11.si, _y.fdx, _11.fdt, _y.nvd, _y.si, _11.fdx, _y.fnm, _y.nvm, _11.fnm, segments_1i, _11_Lucene41_0.doc, _11_Lucene41_0.tim, _y_Lucene41_0.pos, _11_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209477 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 54[_y_Lucene41_0.tip, _y.fdt, _11.si, _y.fdx, _11.fdt, _y.nvd, _y.si, _11.fdx, _y.fnm, _y.nvm, _11.fnm, segments_1i, _11_Lucene41_0.doc, _11_Lucene41_0.tim, _y_Lucene41_0.pos, _11_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> 209480 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@b1dcf8b9 main
[junit4:junit4] 2> 209481 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@b1dcf8b9 main{StandardDirectoryReader(segments_1i:147:nrt _y(4.3):C10 _11(4.3):C1)}
[junit4:junit4] 2> 209481 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209481 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209481 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b1dcf8b9 main{StandardDirectoryReader(segments_1i:147:nrt _y(4.3):C10 _11(4.3):C1)}
[junit4:junit4] 2> 209482 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 38
[junit4:junit4] 2> 209486 T80 C9 REQ [collection1] webapp=/solr path=/select params={q=id:123&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 209487 T77 oas.SolrTestCaseJ4.tearDown ###Ending testUpdateMultiValuedField
[junit4:junit4] 2> 209495 T77 oas.SolrTestCaseJ4.setUp ###Starting testExampleConfig
[junit4:junit4] 2> 209499 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@98b9f530 realtime
[junit4:junit4] 2> 209499 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282023568048128)} 0 2
[junit4:junit4] 2> 209504 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[1112211111 (1429282023573291008)]} 0 2
[junit4:junit4] 2> 209506 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209536 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1i,generation=54,filenames=[_y_Lucene41_0.tip, _y.fdt, _11.si, _y.fdx, _11.fdt, _y.nvd, _y.si, _11.fdx, _y.fnm, _y.nvm, _11.fnm, segments_1i, _11_Lucene41_0.doc, _11_Lucene41_0.tim, _y_Lucene41_0.pos, _11_Lucene41_0.tip, _y_Lucene41_0.tim, _y_Lucene41_0.doc]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1j,generation=55,filenames=[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, segments_1j, _12_Lucene41_0.doc, _12_Lucene41_0.tim, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> 209537 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 55[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, segments_1j, _12_Lucene41_0.doc, _12_Lucene41_0.tim, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> 209541 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@2319ef94 main
[junit4:junit4] 2> 209542 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2319ef94 main{StandardDirectoryReader(segments_1j:151:nrt _12(4.3):C1)}
[junit4:junit4] 2> 209542 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209542 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209543 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2319ef94 main{StandardDirectoryReader(segments_1j:151:nrt _12(4.3):C1)}
[junit4:junit4] 2> 209544 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 38
[junit4:junit4] 2> 209548 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209586 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1j,generation=55,filenames=[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, segments_1j, _12_Lucene41_0.doc, _12_Lucene41_0.tim, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1k,generation=56,filenames=[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, _12_Lucene41_0.doc, _12_Lucene41_0.tim, segments_1k, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> 209587 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 56[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, _12_Lucene41_0.doc, _12_Lucene41_0.tim, segments_1k, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> 209588 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@bc386a4a main
[junit4:junit4] 2> 209588 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@bc386a4a main{StandardDirectoryReader(segments_1j:151:nrt _12(4.3):C1)}
[junit4:junit4] 2> 209588 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209589 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209589 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@bc386a4a main{StandardDirectoryReader(segments_1j:151:nrt _12(4.3):C1)}
[junit4:junit4] 2> 209589 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={maxSegments=1&version=2&waitSearcher=true&wt=javabin&optimize=true} {optimize=} 0 41
[junit4:junit4] 2> 209593 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=id:1112211111&version=2&wt=javabin} hits=1 status=0 QTime=1
[junit4:junit4] 2> 209601 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {add=[2 (1429282023671857152), 3 (1429282023673954304), 4 (1429282023675002880), 5 (1429282023676051456)]} 0 5
[junit4:junit4] 2> 209604 T85 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209626 T85 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1k,generation=56,filenames=[_12.si, _12_Lucene41_0.pos, _12.nvm, _12.fnm, _12.fdt, _12_Lucene41_0.doc, _12_Lucene41_0.tim, segments_1k, _12_Lucene41_0.tip, _12.fdx, _12.nvd]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1l,generation=57,filenames=[_13.si, _12.si, _12.fdt, _13.fdt, _12.fdx, _13.fdx, _12.nvd, _13.nvd, _13_Lucene41_0.pos, _12_Lucene41_0.pos, _12.fnm, _12.nvm, _13_Lucene41_0.doc, _13_Lucene41_0.tim, _13.nvm, _13.fnm, _12_Lucene41_0.tim, _12_Lucene41_0.doc, segments_1l, _13_Lucene41_0.tip, _12_Lucene41_0.tip]
[junit4:junit4] 2> 209627 T85 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 57[_13.si, _12.si, _12.fdt, _13.fdt, _12.fdx, _13.fdx, _12.nvd, _13.nvd, _13_Lucene41_0.pos, _12_Lucene41_0.pos, _12.fnm, _12.nvm, _13_Lucene41_0.doc, _13_Lucene41_0.tim, _13.nvm, _13.fnm, _12_Lucene41_0.tim, _12_Lucene41_0.doc, segments_1l, _13_Lucene41_0.tip, _12_Lucene41_0.tip]
[junit4:junit4] 2> 209629 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@d5a07310 main
[junit4:junit4] 2> 209630 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@d5a07310 main{StandardDirectoryReader(segments_1l:153:nrt _12(4.3):C1 _13(4.3):C4)}
[junit4:junit4] 2> 209630 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209630 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209631 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d5a07310 main{StandardDirectoryReader(segments_1l:153:nrt _12(4.3):C1 _13(4.3):C4)}
[junit4:junit4] 2> 209631 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 27
[junit4:junit4] 2> 209635 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209676 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1l,generation=57,filenames=[_13.si, _12.si, _12.fdt, _13.fdt, _12.fdx, _13.fdx, _12.nvd, _13.nvd, _13_Lucene41_0.pos, _12_Lucene41_0.pos, _12.fnm, _12.nvm, _13_Lucene41_0.doc, _13_Lucene41_0.tim, _13.nvm, _13.fnm, _12_Lucene41_0.tim, _12_Lucene41_0.doc, segments_1l, _13_Lucene41_0.tip, _12_Lucene41_0.tip]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1m,generation=58,filenames=[_14.nvd, _14.si, _14_Lucene41_0.pos, _14_Lucene41_0.doc, _14_Lucene41_0.tim, _14.nvm, _14.fnm, _14_Lucene41_0.tip, _14.fdt, segments_1m, _14.fdx]
[junit4:junit4] 2> 209677 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 58[_14.nvd, _14.si, _14_Lucene41_0.pos, _14_Lucene41_0.doc, _14_Lucene41_0.tim, _14.nvm, _14.fnm, _14_Lucene41_0.tip, _14.fdt, segments_1m, _14.fdx]
[junit4:junit4] 2> 209681 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@fd51edb7 main
[junit4:junit4] 2> 209681 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@fd51edb7 main{StandardDirectoryReader(segments_1m:155:nrt _14(4.3):C5)}
[junit4:junit4] 2> 209681 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209682 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209682 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@fd51edb7 main{StandardDirectoryReader(segments_1m:155:nrt _14(4.3):C5)}
[junit4:junit4] 2> 209684 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={maxSegments=1&version=2&waitSearcher=true&wt=javabin&optimize=true} {optimize=} 0 49
[junit4:junit4] 2> 209698 T86 C9 REQ [collection1] webapp=/solr path=/select params={facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&facet=true&version=2&wt=javabin} hits=5 status=0 QTime=11
[junit4:junit4] 2> 209704 T81 C9 REQ [collection1] webapp=/solr path=/select params={facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&facet.query=price:[5+TO+*]&q=*:*&facet.field=inStock&facet.field=price&facet.field=timestamp_dt&facet=true&version=2&fq=inStock:true&wt=javabin} hits=2 status=0 QTime=1
[junit4:junit4] 2> 209709 T85 C9 REQ [collection1] webapp=/solr path=/select params={facet.query=price:[*+TO+2]&facet.query=price:[2+TO+4]&q=foo&facet=true&version=2&fq={!field+f%3DinStock}true&fq={!term+f%3Dname}hoss&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 209710 T77 oas.SolrTestCaseJ4.tearDown ###Ending testExampleConfig
[junit4:junit4] 2> 209718 T77 oas.SolrTestCaseJ4.setUp ###Starting testContentStreamRequest
[junit4:junit4] 2> 209722 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@458cacd3 realtime
[junit4:junit4] 2> 209723 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282023802929152)} 0 3
[junit4:junit4] 2> 209726 T81 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209766 T81 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1m,generation=58,filenames=[_14.nvd, _14.si, _14_Lucene41_0.pos, _14_Lucene41_0.doc, _14_Lucene41_0.tim, _14.nvm, _14.fnm, _14_Lucene41_0.tip, _14.fdt, segments_1m, _14.fdx]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1n,generation=59,filenames=[segments_1n]
[junit4:junit4] 2> 209767 T81 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 59[segments_1n]
[junit4:junit4] 2> 209769 T81 C9 oass.SolrIndexSearcher.<init> Opening Searcher@d13d3cf2 main
[junit4:junit4] 2> 209770 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@d13d3cf2 main{StandardDirectoryReader(segments_1m:157:nrt)}
[junit4:junit4] 2> 209770 T81 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209770 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209771 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d13d3cf2 main{StandardDirectoryReader(segments_1m:157:nrt)}
[junit4:junit4] 2> 209773 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 47
[junit4:junit4] 2> 209778 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 209815 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 209846 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1n,generation=59,filenames=[segments_1n]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1o,generation=60,filenames=[_15.nvd, _15.si, _15_Lucene41_0.pos, _15_Lucene41_0.doc, _15_Lucene41_0.tim, _15_Lucene41_0.tip, _15.nvm, _15.fnm, _15.fdt, segments_1o, _15.fdx]
[junit4:junit4] 2> 209847 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 60[_15.nvd, _15.si, _15_Lucene41_0.pos, _15_Lucene41_0.doc, _15_Lucene41_0.tim, _15_Lucene41_0.tip, _15.nvm, _15.fnm, _15.fdt, segments_1o, _15.fdx]
[junit4:junit4] 2> 209850 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@45faf68a main
[junit4:junit4] 2> 209851 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@45faf68a main{StandardDirectoryReader(segments_1o:159:nrt _15(4.3):C10)}
[junit4:junit4] 2> 209851 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 209851 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 209852 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@45faf68a main{StandardDirectoryReader(segments_1o:159:nrt _15(4.3):C10)}
[junit4:junit4] 2> 209852 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {add=[0553573403 (1429282023879475200), 0553579908 (1429282023884718080), 055357342X (1429282023887863808), 0553293354 (1429282023889960960), 0812521390 (1429282023893106688), 0812550706 (1429282023895203840), 0441385532 (1429282023897300992), 0380014300 (1429282023898349568), 0805080481 (1429282023899398144), 080508049X (1429282023900446720)],commit=} 0 67
[junit4:junit4] 2> 209856 T86 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=10 status=0 QTime=1
[junit4:junit4] 2> 209859 T77 oas.SolrTestCaseJ4.tearDown ###Ending testContentStreamRequest
[junit4:junit4] 2> 209866 T77 oas.SolrTestCaseJ4.setUp ###Starting testQueryWithParams
[junit4:junit4] 2> 209870 T81 C9 REQ [collection1] webapp=/solr path=/select
[...truncated too long message...]
2> 212108 T85 C9 oass.SolrIndexSearcher.<init> Opening Searcher@afb1c73e main
[junit4:junit4] 2> 212108 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@afb1c73e main{StandardDirectoryReader(segments_1p:167:nrt)}
[junit4:junit4] 2> 212109 T85 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 212109 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 212109 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@afb1c73e main{StandardDirectoryReader(segments_1p:167:nrt)}
[junit4:junit4] 2> 212111 T85 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 55
[junit4:junit4] 2> 212115 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&overwrite=false&wt=javabin} {add=[id1 (1429282026312171520)]} 0 1
[junit4:junit4] 2> 212119 T81 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&overwrite=false&wt=javabin} {add=[id1 (1429282026316365824)]} 0 1
[junit4:junit4] 2> 212122 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 212146 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1q,generation=62,filenames=[segments_1q]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1r,generation=63,filenames=[segments_1r, _18.fdx, _18_Lucene41_0.doc, _18_Lucene41_0.tim, _18_Lucene41_0.tip, _18.fnm, _18.si, _18.fdt]
[junit4:junit4] 2> 212147 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 63[segments_1r, _18.fdx, _18_Lucene41_0.doc, _18_Lucene41_0.tim, _18_Lucene41_0.tip, _18.fnm, _18.si, _18.fdt]
[junit4:junit4] 2> 212149 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@a69486b4 main
[junit4:junit4] 2> 212149 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@a69486b4 main{StandardDirectoryReader(segments_1r:169:nrt _18(4.3):C2)}
[junit4:junit4] 2> 212149 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 212149 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 212150 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a69486b4 main{StandardDirectoryReader(segments_1r:169:nrt _18(4.3):C2)}
[junit4:junit4] 2> 212150 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 28
[junit4:junit4] 2> 212153 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=2 status=0 QTime=0
[junit4:junit4] 2> 212154 T77 oas.SolrTestCaseJ4.tearDown ###Ending testUpdateRequestWithParameters
[junit4:junit4] 2> 212162 T77 oas.SolrTestCaseJ4.setUp ###Starting testPingHandler
[junit4:junit4] 2> 212165 T86 C9 oass.SolrIndexSearcher.<init> Opening Searcher@8c6c930f realtime
[junit4:junit4] 2> 212166 T86 C9 UPDATE [collection1] webapp=/solr path=/update params={version=2&wt=javabin} {deleteByQuery=*:* (-1429282026364600320)} 0 2
[junit4:junit4] 2> 212169 T80 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4:junit4] 2> 212186 T80 C9 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1r,generation=63,filenames=[segments_1r, _18.fdx, _18_Lucene41_0.doc, _18_Lucene41_0.tim, _18_Lucene41_0.tip, _18.fnm, _18.si, _18.fdt]
[junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/index5978759787tmp lockFactory=org.apache.lucene.store.NativeFSLockFactory@da99c51b),segFN=segments_1s,generation=64,filenames=[segments_1s]
[junit4:junit4] 2> 212187 T80 C9 oasc.SolrDeletionPolicy.updateCommits newest commit = 64[segments_1s]
[junit4:junit4] 2> 212188 T80 C9 oass.SolrIndexSearcher.<init> Opening Searcher@2588de5d main
[junit4:junit4] 2> 212189 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@2588de5d main{StandardDirectoryReader(segments_1r:171:nrt)}
[junit4:junit4] 2> 212189 T80 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4:junit4] 2> 212189 T88 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4:junit4] 2> 212189 T88 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@2588de5d main{StandardDirectoryReader(segments_1r:171:nrt)}
[junit4:junit4] 2> 212190 T80 C9 UPDATE [collection1] webapp=/solr path=/update params={softCommit=false&commit=true&version=2&waitSearcher=true&wt=javabin} {commit=} 0 21
[junit4:junit4] 2> 212193 T85 C9 REQ [collection1] webapp=/solr path=/select params={q=*:*&version=2&wt=javabin} hits=0 status=0 QTime=0
[junit4:junit4] 2> 212198 T81 C9 REQ [collection1] webapp=/solr path=/admin/ping params={version=2&wt=javabin} hits=0 status=0 QTime=1
[junit4:junit4] 2> 212198 T81 C9 REQ [collection1] webapp=/solr path=/admin/ping params={version=2&wt=javabin} status=0 QTime=1
[junit4:junit4] 2> 212199 T77 oas.SolrTestCaseJ4.tearDown ###Ending testPingHandler
[junit4:junit4] 2> 212298 T77 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=-1126836896
[junit4:junit4] 2> 212300 T77 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@fbdbb1
[junit4:junit4] 2> 212300 T77 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=64,autocommit maxTime=15000ms,autocommits=1,soft autocommits=3,optimizes=2,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=291,cumulative_deletesById=5,cumulative_deletesByQuery=34,cumulative_errors=1}
[junit4:junit4] 2> 212301 T77 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4:junit4] 2> 212301 T77 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4:junit4] 2> 212302 T77 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4:junit4] 2> 212303 T77 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4:junit4] 2> 212303 T77 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285
[junit4:junit4] 2> 212303 T77 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285
[junit4:junit4] 2> 212304 T77 oasc.CachingDirectoryFactory.close Closing directory when closing factory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/index
[junit4:junit4] 2> 212304 T77 oasc.CachingDirectoryFactory.closeDirectory Closing directory: /mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build/solr-solrj/test/J1/solrtest-SolrExampleJettyTest-1363069347285/index
[junit4:junit4] 2> 212305 T77 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4:junit4] 2> 212356 T77 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4:junit4] 2> NOTE: test params are: codec=Lucene42: {}, docValues:{}, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=fr_FR, timezone=CAT
[junit4:junit4] 2> NOTE: Linux 3.2.0-38-generic amd64/IBM Corporation 1.7.0 (64-bit)/cpus=8,threads=1,free=5590776,total=51707904
[junit4:junit4] 2> NOTE: All tests run in this JVM: [TestSpellCheckResponse, SolrQueryTest, MultiCoreExampleJettyTest, MultiCoreEmbeddedTest, SolrExampleJettyTest]
[junit4:junit4] Completed on J1 in 212.48s, 26 tests, 1 error <<< FAILURES!
[...truncated 25 lines...]
BUILD FAILED
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:381: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:374: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/build.xml:39: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/build.xml:196: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/solr/common-build.xml:449: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:1213: The following error occurred while executing this line:
/mnt/ssd/jenkins/workspace/Lucene-Solr-4.x-Linux/lucene/common-build.xml:877: There were test failures: 45 suites, 259 tests, 1 error, 1 ignored
Total time: 65 minutes 58 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Description set: Java: 64bit/ibm-j9-jdk7
Email was triggered for: Failure
Sending email for trigger: Failure