You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Apache Jenkins Server <je...@builds.apache.org> on 2014/03/02 06:29:56 UTC
[JENKINS] Lucene-Solr-Tests-4.x-Java6 - Build # 2324 - Still
Failing
Build: https://builds.apache.org/job/Lucene-Solr-Tests-4.x-Java6/2324/
1 tests failed.
FAILED: org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes2
Error Message:
key:ignored_creation_date expected:<[2007-10-01T16:13:56Z]> but was:<[]>
Stack Trace:
java.lang.AssertionError: key:ignored_creation_date expected:<[2007-10-01T16:13:56Z]> but was:<[]>
at __randomizedtesting.SeedInfo.seed([1CCD0A2653BB76D8:974DB1C6544DE526]:0)
at org.junit.Assert.fail(Assert.java:93)
at org.junit.Assert.failNotEquals(Assert.java:647)
at org.junit.Assert.assertEquals(Assert.java:128)
at org.apache.solr.morphlines.solr.AbstractSolrMorphlineTestBase.testDocumentTypesInternal(AbstractSolrMorphlineTestBase.java:170)
at org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes2(SolrCellMorphlineTest.java:255)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:616)
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:679)
Build Log:
[...truncated 17705 lines...]
[junit4] Suite: org.apache.solr.morphlines.cell.SolrCellMorphlineTest
[junit4] 2> log4j:WARN No such property [conversionPattern] in org.apache.solr.util.SolrLogLayout.
[junit4] 2> 2602 T10 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 2714 T10 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> Creating dataDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004
[junit4] 2> 2820 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 4814 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 4818 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 4819 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 4821 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 4821 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 4823 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 4823 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 4825 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 4825 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 4826 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 5058 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 5482 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 5506 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 5604 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 7406 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 8091 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 8119 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 8345 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 8346 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr
[junit4] 2> 8346 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/'
[junit4] 2> 8619 T10 oasc.CoreContainer.<init> New CoreContainer 1603443189
[junit4] 2> 8620 T10 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/]
[junit4] 2> 8697 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 8698 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 8707 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 8708 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 8708 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 8709 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 8709 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 8710 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 8710 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 9279 T10 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 9284 T10 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 9291 T10 oasc.CoreContainer.load Host Name:
[junit4] 2> 9694 T11 oasc.CoreContainer.create Creating SolrCore 'collection1' using instanceDir: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1
[junit4] 2> 9695 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 9866 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 9868 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 9869 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 9871 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 9872 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 9873 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 9874 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 9876 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 9877 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 9878 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 9976 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 10129 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 10131 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 10212 T11 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 11003 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 11032 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 11041 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 11253 T11 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 11290 T11 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/, dataDir=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/
[junit4] 2> 11295 T11 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 11352 T11 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 11352 T11 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4] 2> 11501 T11 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004
[junit4] 2> 11502 T11 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index/
[junit4] 2> 11503 T11 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index' doesn't exist. Creating new index...
[junit4] 2> 11516 T11 oasc.CachingDirectoryFactory.get return new directory for /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index
[junit4] 2> 11677 T11 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_1,generation=1}
[junit4] 2> 11681 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 11731 T11 oasc.SolrCore.initWriters created json: solr.JSONResponseWriter
[junit4] 2> 11731 T11 oasc.SolrCore.initWriters adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4] 2> 11735 T11 oasc.SolrCore.initWriters created velocity: solr.VelocityResponseWriter
[junit4] 2> 11787 T11 oasc.SolrCore.initWriters created xslt: solr.XSLTResponseWriter
[junit4] 2> 11787 T11 oasr.XSLTResponseWriter.init xsltCacheLifetimeSeconds=5
[junit4] 2> 13083 T11 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 13213 T11 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 13214 T11 oasc.RequestHandlers.initHandlersFromConfig created /query: solr.SearchHandler
[junit4] 2> 13240 T11 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 13240 T11 oasc.RequestHandlers.initHandlersFromConfig created /browse: solr.SearchHandler
[junit4] 2> 13277 T11 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 13303 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.JsonUpdateRequestHandler]. Please consult documentation how to replace it accordingly.
[junit4] 2> 13304 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json: solr.JsonUpdateRequestHandler
[junit4] 2> 13330 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.CSVRequestHandler]. Please consult documentation how to replace it accordingly.
[junit4] 2> 13330 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: solr.CSVRequestHandler
[junit4] 2> 13331 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4] 2> 13335 T11 oasc.RequestHandlers.initHandlersFromConfig created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4] 2> 13335 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4] 2> 13336 T11 oasc.RequestHandlers.initHandlersFromConfig created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4] 2> 13370 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/: solr.admin.AdminHandlers
[junit4] 2> 13397 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4] 2> 13423 T11 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 13471 T11 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 13471 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 13472 T11 oasc.RequestHandlers.initHandlersFromConfig created /spell: solr.SearchHandler
[junit4] 2> 13472 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 13473 T11 oasc.RequestHandlers.initHandlersFromConfig created /tvrh: solr.SearchHandler
[junit4] 2> 13473 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 13474 T11 oasc.RequestHandlers.initHandlersFromConfig created /terms: solr.SearchHandler
[junit4] 2> 13474 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 13474 T11 oasc.RequestHandlers.initHandlersFromConfig created /elevate: solr.SearchHandler
[junit4] 2> 13617 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 13638 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 13640 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 13741 T11 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 60000ms;
[junit4] 2> 13742 T11 oasu.CommitTracker.<init> Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 13744 T11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_1,generation=1}
[junit4] 2> 13745 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 13799 T11 oass.SolrIndexSearcher.<init> Opening Searcher@1c493dca[collection1] main
[junit4] 2> 13837 T11 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 13939 T11 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] 2> 14037 T11 oashc.SpellCheckComponent.inform No queryConverter defined, using default converter
[junit4] 2> 14054 T11 oashc.QueryElevationComponent.inform Loading QueryElevation from: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 14325 T11 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 14326 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1c493dca[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 14329 T11 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 14397 T10 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 14552 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellJPGCompressed
[junit4] 2> ASYNC NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 15205 T12 C0 oasc.SolrCore.execute [collection1] webapp=null path=null params={event=firstSearcher&q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false} hits=0 status=0 QTime=853
[junit4] 2> 15241 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 15241 T12 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
[junit4] 2> 15242 T12 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
[junit4] 2> 15242 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c493dca[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 15789 T10 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1461440348737765376)} 0 1102
[junit4] 2> 15800 T10 C0 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 15802 T10 C0 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 15804 T10 C0 oass.SolrIndexSearcher.<init> Opening Searcher@6d87c12a[collection1] main
[junit4] 2> 15821 T10 C0 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 15821 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6d87c12a[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 15823 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 15824 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d87c12a[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 15825 T10 C0 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 26
[junit4] 2> 17202 T10 okma.MorphlineContext.importCommandBuilders Importing commands
[junit4] 2> 21736 T10 okma.MorphlineContext.importCommandBuilders Done importing commands
[junit4] 2> 27939 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 28038 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 28039 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 28040 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28042 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 28043 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28044 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 28045 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28046 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 28047 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28048 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 28104 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 28230 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 28231 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 28275 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 28952 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 28979 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 28987 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 29176 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 29268 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 29269 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 29270 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 29271 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 29272 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 29273 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 29274 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 29275 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 29276 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 29277 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 29327 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 29453 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 29454 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 29490 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 30192 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 30218 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 30226 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> ASYNC NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 30295 T10 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1461440364498911232)} 0 2
[junit4] 2> 30296 T10 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 30296 T10 C1 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 30297 T10 C1 oass.SolrIndexSearcher.<init> Opening Searcher@4fee225[collection1] main
[junit4] 2> 30298 T10 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 30298 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4fee225[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 30299 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 30299 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4fee225[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 30300 T10 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 4
[junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 31718 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg#0 (1461440365743570944)]} 0 242
[junit4] 2> 31731 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 32025 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@55d866c5[collection1] main
[junit4] 2> 32026 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32026 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@55d866c5[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.8):C1)}
[junit4] 2> 32027 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 32028 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@55d866c5[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.8):C1)}
[junit4] 2> 32029 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 299
[junit4] 2> 32075 T10 C2 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=37
[junit4] 2> 32144 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg.gz#0 (1461440366436679680)]} 0 6
[junit4] 2> 32145 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 32208 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@56e88e24[collection1] main
[junit4] 2> 32209 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32209 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@56e88e24[collection1] main{StandardDirectoryReader(segments_1:5:nrt _0(4.8):C1 _1(4.8):C1)}
[junit4] 2> 32210 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 32211 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@56e88e24[collection1] main{StandardDirectoryReader(segments_1:5:nrt _0(4.8):C1 _1(4.8):C1)}
[junit4] 2> 32212 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 67
[junit4] 2> 32213 T10 C2 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=2 status=0 QTime=0
[junit4] 2> 32247 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[9e4dab8a-68ca-4686-95a4-f1c99321f8e7#0 (1461440366545731584)]} 0 6
[junit4] 2> 32248 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 32253 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@60ec2ea8[collection1] main
[junit4] 2> 32254 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32254 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@60ec2ea8[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.8):C1 _1(4.8):C1 _2(4.8):C1)}
[junit4] 2> 32255 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 32256 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@60ec2ea8[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.8):C1 _1(4.8):C1 _2(4.8):C1)}
[junit4] 2> 32257 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
[junit4] 2> 32258 T10 C2 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=1
[junit4] 2> 32259 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 32259 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@322ba3e4[collection1] main
[junit4] 2> 32260 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32260 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@322ba3e4[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.8):C1 _1(4.8):C1 _2(4.8):C1)}
[junit4] 2> 32261 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 32262 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@322ba3e4[collection1] main{StandardDirectoryReader(segments_1:7:nrt _0(4.8):C1 _1(4.8):C1 _2(4.8):C1)}
[junit4] 2> 32263 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 4
[junit4] 2> 32264 T10 C2 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=1
[junit4] 2> 32265 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellJPGCompressed
[junit4] 2> 32292 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellDocumentTypes
[junit4] 2> 32429 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@28d320d6[collection1] realtime
[junit4] 2> 32430 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1461440366596063232)} 0 137
[junit4] 2> 32431 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 32432 T10 C2 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_2,generation=2}
[junit4] 2> 32432 T10 C2 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 32433 T10 C2 oass.SolrIndexSearcher.<init> Opening Searcher@64dc420b[collection1] main
[junit4] 2> 32434 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 32434 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@64dc420b[collection1] main{StandardDirectoryReader(segments_1:9:nrt)}
[junit4] 2> 32436 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 32436 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@64dc420b[collection1] main{StandardDirectoryReader(segments_1:9:nrt)}
[junit4] 2> 32440 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 10
[junit4] 2> 32468 T10 okma.MorphlineContext.importCommandBuilders Importing commands
[junit4] 2> 33929 T10 okma.MorphlineContext.importCommandBuilders Done importing commands
[junit4] 2> 35041 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 35125 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 35126 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 35127 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 35128 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 35129 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 35130 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 35131 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 35132 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 35133 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 35133 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 35181 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 35275 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 35276 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 35307 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 35953 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 35977 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 35993 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 36059 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 36145 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 36147 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 36148 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 36149 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 36150 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 36151 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 36151 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 36153 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 36153 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 36154 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 36203 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 36297 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 36298 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 36323 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 36961 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 36984 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 36991 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 40009 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 40090 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 40091 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 40092 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40093 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 40094 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40095 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 40096 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40097 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 40097 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40098 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 40155 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 40246 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 40248 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 40267 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 40909 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 40932 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 40939 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 40968 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 41048 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 41049 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 41050 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41051 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 41052 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41053 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 41053 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41054 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 41055 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41055 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 41102 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 41199 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 41200 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 41218 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 41974 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 42006 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 42014 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 42694 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 42768 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 42769 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 42770 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 42771 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 42772 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 42773 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 42774 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 42775 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 42775 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 42776 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: /non/existent/dir/yields/warning (resolved as: /non/existent/dir/yields/warning).
[junit4] 2> 42823 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_43
[junit4] 2> 42917 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 42919 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 42932 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 43552 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 43574 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 43580 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> ASYNC NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 43609 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1461440378460700672)} 0 1
[junit4] 2> 43610 T10 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 43611 T10 C3 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 43611 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@757f98e7[collection1] main
[junit4] 2> 43612 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 43612 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@757f98e7[collection1] main{StandardDirectoryReader(segments_1:9:nrt)}
[junit4] 2> 43613 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 43614 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@757f98e7[collection1] main{StandardDirectoryReader(segments_1:9:nrt)}
[junit4] 2> 43615 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 5
[junit4] 2> 44094 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testBMPfp.txt#0 (1461440378962968576)]} 0 8
[junit4] 2> 44095 T10 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 44108 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@7f001ba5[collection1] main
[junit4] 2> 44109 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 44109 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7f001ba5[collection1] main{StandardDirectoryReader(segments_2:11:nrt _3(4.8):C1)}
[junit4] 2> 44110 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 44111 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f001ba5[collection1] main{StandardDirectoryReader(segments_2:11:nrt _3(4.8):C1)}
[junit4] 2> 44112 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 17
[junit4] 2> 44113 T10 C3 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=0
[junit4] 2> 44258 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[boilerplate.html#0 (1461440379140177920)]} 0 3
[junit4] 2> 44259 T10 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 44266 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@77984161[collection1] main
[junit4] 2> 44267 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 44267 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@77984161[collection1] main{StandardDirectoryReader(segments_2:13:nrt _3(4.8):C1 _4(4.8):C1)}
[junit4] 2> 44269 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 44269 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@77984161[collection1] main{StandardDirectoryReader(segments_2:13:nrt _3(4.8):C1 _4(4.8):C1)}
[junit4] 2> 44271 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 12
[junit4] 2> 44272 T10 C3 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=2 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 47877 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[NullHeader.docx#0 (1461440382925537280)]} 0 12
[junit4] 2> 47878 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 47919 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@7de4605c[collection1] main
[junit4] 2> 47920 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 47920 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7de4605c[collection1] main{StandardDirectoryReader(segments_2:15:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1)}
[junit4] 2> 47922 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 47923 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7de4605c[collection1] main{StandardDirectoryReader(segments_2:15:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1)}
[junit4] 2> 47924 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 46
[junit4] 2> 47925 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=0
[junit4] 2> 49680 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testWORD_various.doc#0 (1461440384821362688)]} 0 9
[junit4] 2> 49681 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 49692 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@ae4cf81[collection1] main
[junit4] 2> 49693 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 49693 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@ae4cf81[collection1] main{StandardDirectoryReader(segments_2:17:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1)}
[junit4] 2> 49694 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 49694 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ae4cf81[collection1] main{StandardDirectoryReader(segments_2:17:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1)}
[junit4] 2> 49696 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 15
[junit4] 2> 49697 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=4 status=0 QTime=1
[junit4] 2> 51460 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPDF.pdf#0 (1461440386687827968)]} 0 7
[junit4] 2> 51461 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51521 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@3e9f26c7[collection1] main
[junit4] 2> 51522 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51522 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3e9f26c7[collection1] main{StandardDirectoryReader(segments_2:19:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1)}
[junit4] 2> 51523 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51524 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3e9f26c7[collection1] main{StandardDirectoryReader(segments_2:19:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1)}
[junit4] 2> 51525 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 64
[junit4] 2> 51526 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=5 status=0 QTime=0
[junit4] 2> 51562 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg#0 (1461440386791636992)]} 0 13
[junit4] 2> 51563 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51575 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@62b799cf[collection1] main
[junit4] 2> 51576 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51576 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@62b799cf[collection1] main{StandardDirectoryReader(segments_2:21:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1)}
[junit4] 2> 51577 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51577 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@62b799cf[collection1] main{StandardDirectoryReader(segments_2:21:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1)}
[junit4] 2> 51578 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 15
[junit4] 2> 51579 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=6 status=0 QTime=0
[junit4] 2> 51615 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg.gz#0 (1461440386846162944)]} 0 13
[junit4] 2> 51615 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51626 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@b4aa453[collection1] main
[junit4] 2> 51627 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51627 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@b4aa453[collection1] main{StandardDirectoryReader(segments_2:23:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1)}
[junit4] 2> 51628 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51628 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b4aa453[collection1] main{StandardDirectoryReader(segments_2:23:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1)}
[junit4] 2> 51629 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 14
[junit4] 2> 51630 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=7 status=0 QTime=0
[junit4] 2> 51666 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[7b770d63-42e5-4ad7-8094-2124fc862f12 (1461440386901737472)]} 0 12
[junit4] 2> 51667 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51678 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@6d330af4[collection1] main
[junit4] 2> 51679 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51679 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6d330af4[collection1] main{StandardDirectoryReader(segments_2:25:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1)}
[junit4] 2> 51679 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51680 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6d330af4[collection1] main{StandardDirectoryReader(segments_2:25:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1)}
[junit4] 2> 51681 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 14
[junit4] 2> 51682 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=8 status=0 QTime=1
[junit4] 2> 51746 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testXML.xml#0 (1461440386991915008)]} 0 3
[junit4] 2> 51747 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51753 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@28a50395[collection1] main
[junit4] 2> 51754 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51754 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@28a50395[collection1] main{StandardDirectoryReader(segments_2:27:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1)}
[junit4] 2> 51755 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51755 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@28a50395[collection1] main{StandardDirectoryReader(segments_2:27:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1)}
[junit4] 2> 51756 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
[junit4] 2> 51757 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=9 status=0 QTime=0
[junit4] 2> 51769 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[425d71fb-7b5c-496a-8a03-1d614dccebb7 (1461440387012886528), e726be05-b926-4438-9f8c-0fd5c249d930 (1461440387014983680), 0835303a-c29e-450e-add0-4c1963953a6e (1461440387014983681), f124ae9b-22f1-4bbe-9452-055160404022 (1461440387016032256), 8fcfbefc-269e-49ec-8807-2963d8337a64 (1461440387017080832), c8eb437c-cf96-4e3d-93a0-17479f554cad (1461440387017080833)]} 0 5
[junit4] 2> 51770 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51802 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@381f7fbe[collection1] main
[junit4] 2> 51803 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51803 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@381f7fbe[collection1] main{StandardDirectoryReader(segments_2:29:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6)}
[junit4] 2> 51804 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51804 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@381f7fbe[collection1] main{StandardDirectoryReader(segments_2:29:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6)}
[junit4] 2> 51806 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 36
[junit4] 2> 51807 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=15 status=0 QTime=1
[junit4] 2> 51857 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[36c56ef0-7529-4c16-81f2-5a00fccea35a (1461440387093626880), 2f628845-7e62-46e8-baff-ac4b115d74e7 (1461440387099918336), 6bd6e919-5627-43c4-be8a-30be16590cae (1461440387106209792), dbc35c93-c3f8-457d-bd5c-89e1c1a0cbfa (1461440387107258368), 71194185-846f-4849-8b1f-26a0252e66c5 (1461440387108306944), e00b0019-c0a8-4ef4-81b7-a85e5bb41f7c (1461440387109355520)]} 0 16
[junit4] 2> 51857 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51864 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@30791901[collection1] main
[junit4] 2> 51865 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51865 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@30791901[collection1] main{StandardDirectoryReader(segments_2:32:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6 _e(4.8):C6)}
[junit4] 2> 51866 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51866 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@30791901[collection1] main{StandardDirectoryReader(segments_2:32:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6 _e(4.8):C6)}
[junit4] 2> 51868 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 11
[junit4] 2> 51869 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=21 status=0 QTime=1
[junit4] 2> 51893 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[0a853ad2-4041-487d-9ba6-7ea6c301237f (1461440387139764224), be450510-3e01-4a05-b36d-e495d778ab97 (1461440387140812800), 24d79cf1-9e47-4c5b-acc8-ba206cc03521 (1461440387146055680), 22185441-2247-47d0-8d98-6718a7cf3c65 (1461440387147104256)]} 0 8
[junit4] 2> 51894 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51900 T10 C4 oass.SolrIndexSearcher.<init> Opening Searcher@1e1370ab[collection1] main
[junit4] 2> 51900 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51901 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1e1370ab[collection1] main{StandardDirectoryReader(segments_2:34:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6 _e(4.8):C6 _f(4.8):C4)}
[junit4] 2> 51902 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51902 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1e1370ab[collection1] main{StandardDirectoryReader(segments_2:34:nrt _3(4.8):C1 _4(4.8):C1 _5(4.8):C1 _6(4.8):C1 _7(4.8):C1 _8(4.8):C1 _9(4.8):C1 _a(4.8):C1 _b(4.8):C1 _c(4.8):C6 _e(4.8):C6 _f(4.8):C4)}
[junit4] 2> 51904 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 11
[junit4] 2> 51905 T10 C4 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=25 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C5 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 55799 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[1234567890 (1461440391241793536), 2345678901 (1461440391242842112)]} 0 2
[junit4] 2> 55800 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 55806 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@223c8087[collection1] main
[junit4] 2> 55807 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 55807 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@223c8087[collection1] main{StandardDirectoryReader(segments_2:37:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2)}
[junit4] 2> 55808 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 55808 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@223c8087[collection1] main{StandardDirectoryReader(segments_2:37:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2)}
[junit4] 2> 55813 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 13
[junit4] 2> 55814 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=27 status=0 QTime=1
[junit4] 2> 55953 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[1234567891 (1461440391400128512), 2345678902 (1461440391404322816)]} 0 5
[junit4] 2> 55954 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 56013 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@35908558[collection1] main
[junit4] 2> 56014 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 56015 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@35908558[collection1] main{StandardDirectoryReader(segments_2:39:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2)}
[junit4] 2> 56016 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 56016 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@35908558[collection1] main{StandardDirectoryReader(segments_2:39:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2)}
[junit4] 2> 56017 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 63
[junit4] 2> 56019 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=29 status=0 QTime=1
[junit4] 2> 56043 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[5234567890 (1461440391492403200), 6345678901 (1461440391496597504)]} 0 8
[junit4] 2> 56044 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 56055 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@625f4e03[collection1] main
[junit4] 2> 56057 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 56057 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@625f4e03[collection1] main{StandardDirectoryReader(segments_2:41:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2)}
[junit4] 2> 56058 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 56058 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@625f4e03[collection1] main{StandardDirectoryReader(segments_2:41:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2)}
[junit4] 2> 56059 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 15
[junit4] 2> 56061 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=31 status=0 QTime=1
[junit4] 2> 56114 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[3234567890 (1461440391566852096), 4345678901 (1461440391571046400)]} 0 8
[junit4] 2> 56116 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 56130 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@7dd66aa9[collection1] main
[junit4] 2> 56132 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 56132 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7dd66aa9[collection1] main{StandardDirectoryReader(segments_2:43:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2)}
[junit4] 2> 56133 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 56133 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7dd66aa9[collection1] main{StandardDirectoryReader(segments_2:43:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2)}
[junit4] 2> 56134 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 18
[junit4] 2> 56136 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=33 status=0 QTime=1
[junit4] 2> 57255 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[email.eml#0 (1461440392767471616)]} 0 4
[junit4] 2> 57256 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 57262 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@5f98339a[collection1] main
[junit4] 2> 57263 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 57263 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5f98339a[collection1] main{StandardDirectoryReader(segments_2:45:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2 _k(4.8):C1)}
[junit4] 2> 57264 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 57265 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5f98339a[collection1] main{StandardDirectoryReader(segments_2:45:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2 _k(4.8):C1)}
[junit4] 2> 57266 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 10
[junit4] 2> 57267 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=34 status=0 QTime=0
[junit4] 2> 57273 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 57274 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@360088ee[collection1] main
[junit4] 2> 57274 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 57275 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@360088ee[collection1] main{StandardDirectoryReader(segments_2:45:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2 _k(4.8):C1)}
[junit4] 2> 57276 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 57276 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@360088ee[collection1] main{StandardDirectoryReader(segments_2:45:nrt _d(4.8):C15 _e(4.8):C6 _f(4.8):C4 _g(4.8):C2 _h(4.8):C2 _i(4.8):C2 _j(4.8):C2 _k(4.8):C1)}
[junit4] 2> 57277 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 4
[junit4] 2> 57278 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=34 status=0 QTime=1
[junit4] 2> 57283 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellDocumentTypes
[junit4] 2> 57293 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellXML
[junit4] 2> 57296 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@1c2bd9d7[collection1] realtime
[junit4] 2> 57297 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1461440392811511808)} 0 3
[junit4] 2> 57298 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 57299 T10 C5 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCo
[...truncated too long message...]
collection1] main{StandardDirectoryReader(segments_4:53:nrt _m(4.8):C1)}
[junit4] 2> 70045 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 70046 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@d1cfd52[collection1] main{StandardDirectoryReader(segments_4:53:nrt _m(4.8):C1)}
[junit4] 2> 70047 T10 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 9
[junit4] 2> 70048 T10 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C8 name=collection1 org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 72539 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPPT_various.pptx#0 (1461440408794955776)]} 0 3
[junit4] 2> 72541 T10 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 72545 T10 C8 oass.SolrIndexSearcher.<init> Opening Searcher@45a2f279[collection1] main
[junit4] 2> 72546 T10 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 72546 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@45a2f279[collection1] main{StandardDirectoryReader(segments_4:55:nrt _m(4.8):C1 _n(4.8):C1)}
[junit4] 2> 72547 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 72548 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@45a2f279[collection1] main{StandardDirectoryReader(segments_4:55:nrt _m(4.8):C1 _n(4.8):C1)}
[junit4] 2> 72548 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 7
[junit4] 2> 72549 T10 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=2 status=0 QTime=0
[junit4] 2> 73338 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testEXCEL.xlsx#0 (1461440409631719424)]} 0 3
[junit4] 2> 73339 T10 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 73343 T10 C8 oass.SolrIndexSearcher.<init> Opening Searcher@7ed45f89[collection1] main
[junit4] 2> 73344 T10 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 73344 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7ed45f89[collection1] main{StandardDirectoryReader(segments_4:57:nrt _m(4.8):C1 _n(4.8):C1 _o(4.8):C1)}
[junit4] 2> 73345 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 73345 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7ed45f89[collection1] main{StandardDirectoryReader(segments_4:57:nrt _m(4.8):C1 _n(4.8):C1 _o(4.8):C1)}
[junit4] 2> 73346 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 7
[junit4] 2> 73347 T10 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=1
[junit4] 2> 73348 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellDocumentTypes2
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCellMorphlineTest -Dtests.method=testSolrCellDocumentTypes2 -Dtests.seed=1CCD0A2653BB76D8 -Dtests.multiplier=3 -Dtests.slow=true -Dtests.locale=ar_LB -Dtests.timezone=CET -Dtests.file.encoding=ISO-8859-1
[junit4] FAILURE 11.7s | SolrCellMorphlineTest.testSolrCellDocumentTypes2 <<<
[junit4] > Throwable #1: java.lang.AssertionError: key:ignored_creation_date expected:<[2007-10-01T16:13:56Z]> but was:<[]>
[junit4] > at __randomizedtesting.SeedInfo.seed([1CCD0A2653BB76D8:974DB1C6544DE526]:0)
[junit4] > at org.apache.solr.morphlines.solr.AbstractSolrMorphlineTestBase.testDocumentTypesInternal(AbstractSolrMorphlineTestBase.java:170)
[junit4] > at org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes2(SolrCellMorphlineTest.java:255)
[junit4] > at java.lang.Thread.run(Thread.java:679)
[junit4] 2> 73402 T10 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 73402 T10 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1603443189
[junit4] 2> 73403 T10 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2d9845fb
[junit4] 2> 73405 T10 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=36,autocommit maxTime=60000ms,autocommits=0,soft autocommit maxTime=1000ms,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=41,cumulative_deletesById=0,cumulative_deletesByQuery=9,cumulative_errors=0,transaction_logs_total_size=53409,transaction_logs_total_number=9}
[junit4] 2> 73408 T10 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 73408 T10 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 73409 T10 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 73418 T10 C8 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@3c2c7ac5 lockFactory=NativeFSLockFactory@/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index),segFN=segments_5,generation=5}
[junit4] 2> 73418 T10 C8 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 73421 T10 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 73421 T10 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 73422 T10 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index;done=false>>]
[junit4] 2> 73423 T10 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004/index
[junit4] 2> 73423 T10 oasc.CachingDirectoryFactory.closeCacheValue looking to close /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004 [CachedDir<<refCount=0;path=/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004;done=false>>]
[junit4] 2> 73424 T10 oasc.CachingDirectoryFactory.close Closing directory: /usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build/contrib/solr-morphlines-cell/test/J0/./solrtest-SolrCellMorphlineTest-1393738113004
[junit4] 2> NOTE: test params are: codec=Lucene3x, sim=RandomSimilarityProvider(queryNorm=true,coord=no): {}, locale=ar_LB, timezone=CET
[junit4] 2> NOTE: FreeBSD 9.1-RELEASE-p3 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=16,threads=1,free=337712896,total=489291776
[junit4] 2> NOTE: All tests run in this JVM: [SolrCellMorphlineTest]
[junit4] Completed in 74.13s, 5 tests, 1 failure <<< FAILURES!
[...truncated 9 lines...]
BUILD FAILED
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/build.xml:471: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/build.xml:451: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/build.xml:39: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/extra-targets.xml:37: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/build.xml:209: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/common-build.xml:440: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/solr/common-build.xml:490: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/common-build.xml:1278: The following error occurred while executing this line:
/usr/home/hudson/hudson-slave/workspace/Lucene-Solr-Tests-4.x-Java6/lucene/common-build.xml:911: There were test failures: 1 suite, 5 tests, 1 failure
Total time: 97 minutes 51 seconds
Build step 'Invoke Ant' marked build as failure
Archiving artifacts
Recording test results
Email was triggered for: Failure
Sending email for trigger: Failure