You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by Policeman Jenkins Server <je...@thetaphi.de> on 2014/06/26 22:04:21 UTC
[JENKINS] Lucene-Solr-4.x-MacOSX (64bit/jdk1.7.0) - Build # 1639 -
Failure!
Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-MacOSX/1639/
Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseSerialGC
1 tests failed.
FAILED: org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes
Error Message:
key:ignored__attachment_mimetype expected:<[message/rfc822]> but was:<[text/plain]>
Stack Trace:
java.lang.AssertionError: key:ignored__attachment_mimetype expected:<[message/rfc822]> but was:<[text/plain]>
at __randomizedtesting.SeedInfo.seed([528B56833D4FE9B8:C848F51D5894B76D]: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.testSolrCellDocumentTypes(SolrCellMorphlineTest.java:193)
at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57)
at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
at java.lang.reflect.Method.invoke(Method.java:606)
at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618)
at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827)
at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863)
at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877)
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:65)
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:360)
at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:793)
at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:453)
at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836)
at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738)
at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772)
at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783)
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 com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36)
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:65)
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:360)
at java.lang.Thread.run(Thread.java:745)
Build Log:
[...truncated 19252 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> Creating dataDir: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001
[junit4] 2> 3210 T10 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false)
[junit4] 2> 3325 T10 oas.SolrTestCaseJ4.initCore ####initCore
[junit4] 2> 3461 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 5775 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 5780 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 5782 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 5783 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 5785 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 5787 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 5788 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 5789 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 5791 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 5792 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> 6140 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 6726 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 6760 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 6918 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 7538 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.IntField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 7562 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.LongField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 7599 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.FloatField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 7655 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.DoubleField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 7686 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.DateField]. Please consult documentation how to replace it accordingly.
[junit4] 2> 9005 T10 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.ThaiWordFilterFactory]. Please consult documentation how to replace it accordingly.
[junit4] 2> 9131 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 9828 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 9872 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 10260 T10 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx)
[junit4] 2> 10262 T10 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr
[junit4] 2> 10262 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/'
[junit4] 2> 10575 T10 oasc.CoreContainer.<init> New CoreContainer 1646630436
[junit4] 2> 10576 T10 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/]
[junit4] 2> 10664 T10 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0
[junit4] 2> 10664 T10 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null
[junit4] 2> 10712 T10 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0
[junit4] 2> 10712 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20
[junit4] 2> 10713 T10 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0
[junit4] 2> 10714 T10 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647
[junit4] 2> 10715 T10 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5
[junit4] 2> 10716 T10 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1
[junit4] 2> 10717 T10 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false
[junit4] 2> 11445 T10 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory
[junit4] 2> 11450 T10 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)]
[junit4] 2> 11458 T10 oasc.CoreContainer.load Host Name:
[junit4] 2> 11960 T11 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 12208 T11 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 12210 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 12211 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 12213 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 12214 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 12215 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 12216 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 12218 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 12219 T11 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 12220 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> 12359 T11 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 12504 T11 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 12507 T11 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 12668 T11 oass.IndexSchema.readSchema [collection1] Schema name=example
[junit4] 2> 13460 T11 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 13506 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 13518 T11 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 13649 T11 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/
[junit4] 2> 13816 T11 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory
[junit4] 2> 13854 T11 oasc.SolrCore.<init> [collection1] Opening new SolrCore at /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/, dataDir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/
[junit4] 2> 13860 T11 oasc.JmxMonitoredMap.<init> No JMX servers found, not exposing Solr information with JMX.
[junit4] 2> 13920 T11 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for newSearcher: org.apache.solr.core.QuerySenderListener{queries=[]}
[junit4] 2> 13920 T11 oasc.SolrCore.initListeners [collection1] Added SolrEventListener for firstSearcher: org.apache.solr.core.QuerySenderListener{queries=[{q=static firstSearcher warming in solrconfig.xml}]}
[junit4] 2> 14064 T11 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001
[junit4] 2> 14066 T11 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index/
[junit4] 2> 14066 T11 oasc.SolrCore.initIndex WARN [collection1] Solr index directory '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index' doesn't exist. Creating new index...
[junit4] 2> 14083 T11 oasc.CachingDirectoryFactory.get return new directory for /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index
[junit4] 2> 14304 T11 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 14309 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 14363 T11 oasc.SolrCore.initWriters created json: solr.JSONResponseWriter
[junit4] 2> 14363 T11 oasc.SolrCore.initWriters adding lazy queryResponseWriter: solr.VelocityResponseWriter
[junit4] 2> 14369 T11 oasc.SolrCore.initWriters created velocity: solr.VelocityResponseWriter
[junit4] 2> 14422 T11 oasc.SolrCore.initWriters created xslt: solr.XSLTResponseWriter
[junit4] 2> 14422 T11 oasr.XSLTResponseWriter.init xsltCacheLifetimeSeconds=5
[junit4] 2> 15824 T11 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default
[junit4] 2> 15950 T11 oasc.RequestHandlers.initHandlersFromConfig created /select: solr.SearchHandler
[junit4] 2> 15951 T11 oasc.RequestHandlers.initHandlersFromConfig created /query: solr.SearchHandler
[junit4] 2> 15976 T11 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler
[junit4] 2> 15976 T11 oasc.RequestHandlers.initHandlersFromConfig created /browse: solr.SearchHandler
[junit4] 2> 16027 T11 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler
[junit4] 2> 16055 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.JsonUpdateRequestHandler]. Please consult documentation how to replace it accordingly.
[junit4] 2> 16055 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/json: solr.JsonUpdateRequestHandler
[junit4] 2> 16081 T11 oasc.SolrResourceLoader.findClass WARN Solr loaded a deprecated plugin/analysis class [solr.CSVRequestHandler]. Please consult documentation how to replace it accordingly.
[junit4] 2> 16082 T11 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: solr.CSVRequestHandler
[junit4] 2> 16082 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.FieldAnalysisRequestHandler
[junit4] 2> 16087 T11 oasc.RequestHandlers.initHandlersFromConfig created /analysis/field: solr.FieldAnalysisRequestHandler
[junit4] 2> 16087 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.DocumentAnalysisRequestHandler
[junit4] 2> 16088 T11 oasc.RequestHandlers.initHandlersFromConfig created /analysis/document: solr.DocumentAnalysisRequestHandler
[junit4] 2> 16119 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/: solr.admin.AdminHandlers
[junit4] 2> 16144 T11 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: solr.PingRequestHandler
[junit4] 2> 16171 T11 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler
[junit4] 2> 16222 T11 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler
[junit4] 2> 16223 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 16224 T11 oasc.RequestHandlers.initHandlersFromConfig created /spell: solr.SearchHandler
[junit4] 2> 16225 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 16225 T11 oasc.RequestHandlers.initHandlersFromConfig created /tvrh: solr.SearchHandler
[junit4] 2> 16226 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 16226 T11 oasc.RequestHandlers.initHandlersFromConfig created /terms: solr.SearchHandler
[junit4] 2> 16227 T11 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.SearchHandler
[junit4] 2> 16227 T11 oasc.RequestHandlers.initHandlersFromConfig created /elevate: solr.SearchHandler
[junit4] 2> 16396 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16422 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16424 T11 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60
[junit4] 2> 16546 T11 oasu.CommitTracker.<init> Hard AutoCommit: if uncommited for 60000ms;
[junit4] 2> 16547 T11 oasu.CommitTracker.<init> Soft AutoCommit: if uncommited for 1000ms;
[junit4] 2> 16559 T11 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> 16559 T11 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1
[junit4] 2> 16619 T11 oass.SolrIndexSearcher.<init> Opening Searcher@4c254927[collection1] main
[junit4] 2> 16676 T11 oasr.ManagedResourceStorage$FileStorageIO.configure File-based storage initialized to use dir: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf
[junit4] 2> 16677 T11 oasr.RestManager.init Initializing RestManager with initArgs: {storageDir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf/}
[junit4] 2> 16760 T11 oasr.ManagedResourceStorage.load Reading _rest_managed.json using file:dir=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf
[junit4] 2> 16761 T11 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed
[junit4] 2> 16761 T11 oasr.ManagedResource.notifyObserversDuringInit WARN No registered observers for /rest/managed
[junit4] 2> 16762 T11 oasr.RestManager.init Initializing 0 registered ManagedResources
[junit4] 2> 16762 T11 oashc.SpellCheckComponent.inform Initializing spell checkers
[junit4] 2> 16876 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> 16985 T11 oashc.SpellCheckComponent.inform No queryConverter defined, using default converter
[junit4] 2> 17002 T11 oashc.QueryElevationComponent.inform Loading QueryElevation from: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/conf/elevate.xml
[junit4] 2> 17330 T11 oash.ReplicationHandler.inform Commits will be reserved for 10000
[junit4] 2> 17331 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4c254927[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> 17335 T11 oasc.CoreContainer.registerCore registering core: collection1
[junit4] 2> 17360 T10 oas.SolrTestCaseJ4.initCore ####initCore end
[junit4] 2> 17420 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellXML
[junit4] 2> ASYNC NEW_CORE C0 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 17775 T12 C0 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=static+firstSearcher+warming+in+solrconfig.xml&distrib=false&event=firstSearcher} hits=0 status=0 QTime=426
[junit4] 2> 17785 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 17785 T12 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: default
[junit4] 2> 17786 T12 oashc.SpellCheckComponent$SpellCheckerListener.newSearcher Loading spell index for spellchecker: wordbreak
[junit4] 2> 17787 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4c254927[collection1] main{StandardDirectoryReader(segments_1:1:nrt)}
[junit4] 2> ASYNC NEW_CORE C1 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 18279 T10 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1472004578333425664)} 0 782
[junit4] 2> 18287 T10 C1 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 18288 T10 C1 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 18289 T10 C1 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 18291 T10 C1 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 18291 T10 C1 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 5
[junit4] 2> 19341 T10 okma.MorphlineContext.importCommandBuilders Importing commands
[junit4] 2> 24915 T10 okma.MorphlineContext.importCommandBuilders Done importing commands
[junit4] 2> 25005 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 25174 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 25175 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 25176 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 25178 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 25178 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 25180 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 25181 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 25182 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 25183 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 25184 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> 25265 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 25379 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 25382 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 25441 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 26238 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 26275 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 26285 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 26543 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 26661 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 26663 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 26664 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 26668 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 26669 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 26670 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 26670 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 26672 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 26672 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 26673 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> 26738 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 26980 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 26980 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 27117 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 27878 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 27916 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 27931 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 28003 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 28134 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 28135 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 28136 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28137 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 28138 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28139 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 28139 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28140 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 28141 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 28142 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> 28205 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 28309 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 28311 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 28352 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 29014 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 29050 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 29060 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> ASYNC NEW_CORE C2 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 29253 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1472004590275657728)} 0 2
[junit4] 2> 29255 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 29255 T10 C2 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 29256 T10 C2 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 29256 T10 C2 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 29257 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 2
[junit4] 2> 29939 T10 C2 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testXML2.xml#0 (1472004590735982592)]} 0 250
[junit4] 2> 29962 T10 C2 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C3 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 30251 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@688177ce[collection1] main
[junit4] 2> 30266 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 30266 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@688177ce[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.10):C1)}
[junit4] 2> 30268 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 30269 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@688177ce[collection1] main{StandardDirectoryReader(segments_1:3:nrt _0(4.10):C1)}
[junit4] 2> 30270 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 308
[junit4] 2> 30320 T10 C3 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=40
[junit4] 2> 30339 T10 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 30340 T10 C3 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 30340 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 30341 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 2
[junit4] 2> 30342 T10 C3 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=0
[junit4] 2> 30343 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellXML
[junit4] 2> 30383 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellDocumentTypes
[junit4] 2> 30602 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@772ce69f[collection1] realtime
[junit4] 2> 30603 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1472004591467888640)} 0 215
[junit4] 2> 30605 T10 C3 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 30606 T10 C3 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_1,generation=1}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_2,generation=2}
[junit4] 2> 30606 T10 C3 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2
[junit4] 2> 30608 T10 C3 oass.SolrIndexSearcher.<init> Opening Searcher@73413367[collection1] main
[junit4] 2> 30609 T10 C3 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 30610 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@73413367[collection1] main{StandardDirectoryReader(segments_1:5:nrt)}
[junit4] 2> 30610 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 30610 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@73413367[collection1] main{StandardDirectoryReader(segments_1:5:nrt)}
[junit4] 2> 30615 T10 C3 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 11
[junit4] 2> 30666 T10 okma.MorphlineContext.importCommandBuilders Importing commands
[junit4] 2> 32563 T10 okma.MorphlineContext.importCommandBuilders Done importing commands
[junit4] 2> 40601 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 40733 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 40735 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 40737 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40740 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 40742 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40744 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 40746 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40748 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 40753 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 40757 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> 40836 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 40943 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 40944 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 40994 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 41671 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 41712 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 41722 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 41813 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 41920 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 41922 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 41923 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41925 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 41926 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41928 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 41929 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41931 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 41933 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 41935 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> 42081 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 42271 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 42273 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 42324 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 43006 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 43038 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 43047 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 46156 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 46252 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 46253 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 46254 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 46255 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 46256 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 46257 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 46258 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 46259 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 46260 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 46260 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> 46339 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 46438 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 46440 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 46464 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 47249 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 47286 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 47293 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 47332 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 47426 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 47427 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 47428 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 47429 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 47430 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 47431 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 47432 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 47433 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 47434 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 47435 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> 47501 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 47599 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 47601 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 47641 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 48331 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 48369 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 48376 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 48979 T10 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: '/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/'
[junit4] 2> 49108 T10 oasc.SolrConfig.initLibs Adding specified lib dirs to ClassLoader
[junit4] 2> 49110 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/extraction/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/extraction/lib).
[junit4] 2> 49111 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 49112 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/clustering/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/clustering/lib).
[junit4] 2> 49113 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 49114 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/langid/lib/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/langid/lib).
[junit4] 2> 49115 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 49116 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../contrib/velocity/lib (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../contrib/velocity/lib).
[junit4] 2> 49117 T10 oasc.SolrResourceLoader.addToClassLoader WARN Can't find (or read) directory to add to classloader: ../../../dist/ (resolved as: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/contrib/morphlines-core/src/test-files/solr/collection1/../../../dist).
[junit4] 2> 49118 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> 49173 T10 oasc.SolrConfig.<init> Using Lucene MatchVersion: LUCENE_4_10
[junit4] 2> 49273 T10 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml
[junit4] 2> 49274 T10 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml
[junit4] 2> 49301 T10 oass.IndexSchema.readSchema [null] Schema name=example
[junit4] 2> 49932 T10 oass.IndexSchema.readSchema unique key field: id
[junit4] 2> 49970 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> 49977 T10 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml
[junit4] 2> ASYNC NEW_CORE C4 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 50031 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1472004612062969856)} 0 2
[junit4] 2> 50032 T10 C4 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 50032 T10 C4 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit.
[junit4] 2> 50033 T10 C4 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 50034 T10 C4 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 50035 T10 C4 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 3
[junit4] 2> ASYNC NEW_CORE C5 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 51086 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testBMPfp.txt#0 (1472004613147197440)]} 0 25
[junit4] 2> 51087 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51172 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@5f365217[collection1] main
[junit4] 2> 51173 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5f365217[collection1] main{StandardDirectoryReader(segments_2:7:nrt _1(4.10):C1)}
[junit4] 2> 51174 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51175 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5f365217[collection1] main{StandardDirectoryReader(segments_2:7:nrt _1(4.10):C1)}
[junit4] 2> 51175 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51176 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 90
[junit4] 2> 51180 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=1 status=0 QTime=4
[junit4] 2> 51434 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[boilerplate.html#0 (1472004613533073408)]} 0 4
[junit4] 2> 51435 T10 C5 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 51454 T10 C5 oass.SolrIndexSearcher.<init> Opening Searcher@5dc9dbe1[collection1] main
[junit4] 2> 51455 T10 C5 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 51455 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@5dc9dbe1[collection1] main{StandardDirectoryReader(segments_2:9:nrt _1(4.10):C1 _2(4.10):C1)}
[junit4] 2> 51456 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 51458 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5dc9dbe1[collection1] main{StandardDirectoryReader(segments_2:9:nrt _1(4.10):C1 _2(4.10):C1)}
[junit4] 2> 51460 T10 C5 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 25
[junit4] 2> 51462 T10 C5 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=2 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C6 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 55799 T10 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[NullHeader.docx#0 (1472004618096476160)]} 0 18
[junit4] 2> 55800 T10 C6 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 55855 T10 C6 oass.SolrIndexSearcher.<init> Opening Searcher@7424a9b4[collection1] main
[junit4] 2> 55855 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@7424a9b4[collection1] main{StandardDirectoryReader(segments_2:11:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1)}
[junit4] 2> 55856 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 55856 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7424a9b4[collection1] main{StandardDirectoryReader(segments_2:11:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1)}
[junit4] 2> 55857 T10 C6 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 55858 T10 C6 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 58
[junit4] 2> 55859 T10 C6 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=3 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C7 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 57982 T10 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testWORD_various.doc#0 (1472004620382371840)]} 0 26
[junit4] 2> 57983 T10 C7 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 58000 T10 C7 oass.SolrIndexSearcher.<init> Opening Searcher@61419aa7[collection1] main
[junit4] 2> 58001 T10 C7 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 58001 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@61419aa7[collection1] main{StandardDirectoryReader(segments_2:13:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1)}
[junit4] 2> 58002 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 58003 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@61419aa7[collection1] main{StandardDirectoryReader(segments_2:13:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1)}
[junit4] 2> 58004 T10 C7 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 21
[junit4] 2> 58005 T10 C7 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=4 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C8 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 60231 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testPDF.pdf#0 (1472004622753202176)]} 0 9
[junit4] 2> 60232 T10 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 60247 T10 C8 oass.SolrIndexSearcher.<init> Opening Searcher@3dd6dd04[collection1] main
[junit4] 2> 60249 T10 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 60249 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@3dd6dd04[collection1] main{StandardDirectoryReader(segments_2:15:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1)}
[junit4] 2> 60250 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 60251 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@3dd6dd04[collection1] main{StandardDirectoryReader(segments_2:15:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1)}
[junit4] 2> 60253 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 21
[junit4] 2> 60254 T10 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=5 status=0 QTime=0
[junit4] 2> 60739 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg#0 (1472004623278538752)]} 0 18
[junit4] 2> 60740 T10 C8 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 60760 T10 C8 oass.SolrIndexSearcher.<init> Opening Searcher@40afbec6[collection1] main
[junit4] 2> 60762 T10 C8 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 60762 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@40afbec6[collection1] main{StandardDirectoryReader(segments_2:17:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1)}
[junit4] 2> 60764 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 60764 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40afbec6[collection1] main{StandardDirectoryReader(segments_2:17:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1)}
[junit4] 2> 60766 T10 C8 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 26
[junit4] 2> 60767 T10 C8 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=6 status=0 QTime=0
[junit4] 2> ASYNC NEW_CORE C9 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 60851 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testJPEG_EXIF.jpg.gz#0 (1472004623375007744)]} 0 39
[junit4] 2> 60852 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 60870 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@6801357b[collection1] main
[junit4] 2> 60872 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 60872 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@6801357b[collection1] main{StandardDirectoryReader(segments_2:19:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1)}
[junit4] 2> 60873 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 60874 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@6801357b[collection1] main{StandardDirectoryReader(segments_2:19:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1)}
[junit4] 2> 60875 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 23
[junit4] 2> 60876 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=7 status=0 QTime=0
[junit4] 2> 60977 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[23f12e24-97f0-4c54-95ac-107fcf2070a8 (1472004623505031168)]} 0 40
[junit4] 2> 60977 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 60997 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1c09a835[collection1] main
[junit4] 2> 61000 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 61000 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1c09a835[collection1] main{StandardDirectoryReader(segments_2:21:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1)}
[junit4] 2> 61002 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 61002 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c09a835[collection1] main{StandardDirectoryReader(segments_2:21:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1)}
[junit4] 2> 61003 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 26
[junit4] 2> 61004 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=8 status=0 QTime=0
[junit4] 2> 61064 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testXML.xml#0 (1472004623626665984)]} 0 7
[junit4] 2> 61065 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 61076 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@14dcca5c[collection1] main
[junit4] 2> 61078 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 61088 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@14dcca5c[collection1] main{StandardDirectoryReader(segments_2:23:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1)}
[junit4] 2> 61089 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 61089 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14dcca5c[collection1] main{StandardDirectoryReader(segments_2:23:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1)}
[junit4] 2> 61097 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 32
[junit4] 2> 61099 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=9 status=0 QTime=1
[junit4] 2> 61130 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[be6ea332-b4f5-4147-88c8-92fe93a745df (1472004623696920576), 628efbc8-69e9-4143-acc5-ef33deb5dec1 (1472004623701114880), 47ac4589-14a6-4843-b755-6fed6b2a7dd9 (1472004623701114881), b2acb00e-ad86-4cd2-9c14-daabf205278b (1472004623702163456), 8e347119-3a52-4abb-a061-1820d4089eee (1472004623703212032), 9263314c-b655-4390-94b1-c99f2bce5456 (1472004623703212033)]} 0 6
[junit4] 2> 61132 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 61168 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@1a815921[collection1] main
[junit4] 2> 61170 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@1a815921[collection1] main{StandardDirectoryReader(segments_2:25:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6)}
[junit4] 2> 61171 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 61172 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a815921[collection1] main{StandardDirectoryReader(segments_2:25:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6)}
[junit4] 2> 61173 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 61174 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 42
[junit4] 2> 61175 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=15 status=0 QTime=0
[junit4] 2> 61354 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[87a6384e-8bf6-43f0-b7ec-4386c3a7dcac (1472004623933898752), 958be269-7082-455b-9b59-065bbcfde68d (1472004623934947328), bfaa644a-a57e-466d-9a99-feddd4afafe2 (1472004623935995904), 989791a8-5b01-4a79-ac37-5be15f975bb2 (1472004623935995905), 9c713eaf-9f71-4e38-ada2-d3681ab12b15 (1472004623935995906), d69528b1-810c-4eab-b1a3-96844ab97ea6 (1472004623937044480)]} 0 3
[junit4] 2> 61355 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 61375 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@4d691ce7[collection1] main
[junit4] 2> 61376 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 61376 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4d691ce7[collection1] main{StandardDirectoryReader(segments_2:28:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6 _c(4.10):C6)}
[junit4] 2> 61378 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 61379 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4d691ce7[collection1] main{StandardDirectoryReader(segments_2:28:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6 _c(4.10):C6)}
[junit4] 2> 61385 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 30
[junit4] 2> 61387 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=21 status=0 QTime=1
[junit4] 2> 61416 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[0575cba4-12db-4ab8-a9c6-237e7f1c0790 (1472004623995764736), bcafa7b9-49b3-4817-8618-c5259f9690bb (1472004623996813312), 73e72ea5-5bdd-4950-9a1a-cf15f09d9579 (1472004624001007616), 6b92e21b-34f6-40c3-8851-ad8773105600 (1472004624002056192)]} 0 7
[junit4] 2> 61417 T10 C9 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 61453 T10 C9 oass.SolrIndexSearcher.<init> Opening Searcher@72bab97b[collection1] main
[junit4] 2> 61458 T10 C9 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 61459 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@72bab97b[collection1] main{StandardDirectoryReader(segments_2:30:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6 _c(4.10):C6 _d(4.10):C4)}
[junit4] 2> 61483 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 61484 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@72bab97b[collection1] main{StandardDirectoryReader(segments_2:30:nrt _1(4.10):C1 _2(4.10):C1 _3(4.10):C1 _4(4.10):C1 _5(4.10):C1 _6(4.10):C1 _7(4.10):C1 _8(4.10):C1 _9(4.10):C1 _a(4.10):C6 _c(4.10):C6 _d(4.10):C4)}
[junit4] 2> 61487 T10 C9 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 71
[junit4] 2> 61489 T10 C9 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=25 status=0 QTime=1
[junit4] 2> ASYNC NEW_CORE C10 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 65638 T10 C10 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[1234567890 (1472004628428095488), 2345678901 (1472004628429144064)]} 0 2
[junit4] 2> 65639 T10 C10 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 65647 T10 C10 oass.SolrIndexSearcher.<init> Opening Searcher@71a91692[collection1] main
[junit4] 2> 65648 T10 C10 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 65648 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@71a91692[collection1] main{StandardDirectoryReader(segments_2:33:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2)}
[junit4] 2> 65649 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 65649 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@71a91692[collection1] main{StandardDirectoryReader(segments_2:33:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2)}
[junit4] 2> 65652 T10 C10 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 13
[junit4] 2> 65655 T10 C10 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=27 status=0 QTime=1
[junit4] 2> 65798 T10 C10 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[1234567891 (1472004628590624768), 2345678902 (1472004628596916224)]} 0 8
[junit4] 2> 65800 T10 C10 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> ASYNC NEW_CORE C11 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 65843 T10 C11 oass.SolrIndexSearcher.<init> Opening Searcher@54c4d8c4[collection1] main
[junit4] 2> 65845 T10 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 65845 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@54c4d8c4[collection1] main{StandardDirectoryReader(segments_2:35:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2)}
[junit4] 2> 65847 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 65847 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@54c4d8c4[collection1] main{StandardDirectoryReader(segments_2:35:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2)}
[junit4] 2> 65849 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 49
[junit4] 2> 65850 T10 C11 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=29 status=0 QTime=1
[junit4] 2> 65869 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[5234567890 (1472004628666122240), 6345678901 (1472004628671365120)]} 0 7
[junit4] 2> 65871 T10 C11 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 65882 T10 C11 oass.SolrIndexSearcher.<init> Opening Searcher@4950d8be[collection1] main
[junit4] 2> 65883 T10 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 65883 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4950d8be[collection1] main{StandardDirectoryReader(segments_2:37:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2)}
[junit4] 2> 65885 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 65886 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4950d8be[collection1] main{StandardDirectoryReader(segments_2:37:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2)}
[junit4] 2> 65889 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 19
[junit4] 2> 65890 T10 C11 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=31 status=0 QTime=0
[junit4] 2> 65931 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[3234567890 (1472004628732182528), 4345678901 (1472004628736376832)]} 0 5
[junit4] 2> 65932 T10 C11 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 65945 T10 C11 oass.SolrIndexSearcher.<init> Opening Searcher@66938a3e[collection1] main
[junit4] 2> 65946 T10 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 65946 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@66938a3e[collection1] main{StandardDirectoryReader(segments_2:39:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2 _h(4.10):C2)}
[junit4] 2> 65947 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 65947 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@66938a3e[collection1] main{StandardDirectoryReader(segments_2:39:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2 _h(4.10):C2)}
[junit4] 2> 65948 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 16
[junit4] 2> 65950 T10 C11 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=33 status=0 QTime=1
[junit4] 2> 65976 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[email.eml#0 (1472004628780417024)]} 0 5
[junit4] 2> 65977 T10 C11 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 65988 T10 C11 oass.SolrIndexSearcher.<init> Opening Searcher@19923696[collection1] main
[junit4] 2> 65989 T10 C11 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 65989 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@19923696[collection1] main{StandardDirectoryReader(segments_2:41:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2 _h(4.10):C2 _i(4.10):C1)}
[junit4] 2> 66000 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 66000 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19923696[collection1] main{StandardDirectoryReader(segments_2:41:nrt _b(4.10):C15 _c(4.10):C6 _d(4.10):C4 _e(4.10):C2 _f(4.10):C2 _g(4.10):C2 _h(4.10):C2 _i(4.10):C1)}
[junit4] 2> 66008 T10 C11 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 31
[junit4] 2> 66009 T10 C11 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=34 status=0 QTime=1
[junit4] 2> 66017 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellDocumentTypes
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=SolrCellMorphlineTest -Dtests.method=testSolrCellDocumentTypes -Dtests.seed=528B56833D4FE9B8 -Dtests.slow=true -Dtests.locale=tr -Dtests.timezone=Asia/Ashkhabad -Dtests.file.encoding=UTF-8
[junit4] FAILURE 35.8s | SolrCellMorphlineTest.testSolrCellDocumentTypes <<<
[junit4] > Throwable #1: java.lang.AssertionError: key:ignored__attachment_mimetype expected:<[message/rfc822]> but was:<[text/plain]>
[junit4] > at __randomizedtesting.SeedInfo.seed([528B56833D4FE9B8:C848F51D5894B76D]:0)
[junit4] > at org.apache.solr.morphlines.solr.AbstractSolrMorphlineTestBase.testDocumentTypesInternal(AbstractSolrMorphlineTestBase.java:170)
[junit4] > at org.apache.solr.morphlines.cell.SolrCellMorphlineTest.testSolrCellDocumentTypes(SolrCellMorphlineTest.java:193)
[junit4] > at java.lang.Thread.run(Thread.java:745)
[junit4] 2> 66141 T10 oas.SolrTestCaseJ4.setUp ###Starting testSolrCellJPGCompressed
[junit4] 2> 66148 T10 C11 oass.SolrIndexSearcher.<init> Opening Searcher@2974ea1b[collection1] realtime
[junit4] 2> 66149 T10 C11 oasup.LogUpdateProcessor.finish [collection1] we
[...truncated too long message...]
4.10):C1 _19(4.10):C1)}
[junit4] 2> 91921 T10 C17 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 91922 T10 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 88
[junit4] 2> 91923 T10 C17 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=22 status=0 QTime=0
[junit4] 2> 92343 T10 C17 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {add=[testVISIO.vsd#0 (1472004656430317568)]} 0 6
[junit4] 2> 92344 T10 C17 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 92350 T10 C17 oass.SolrIndexSearcher.<init> Opening Searcher@434256a5[collection1] main
[junit4] 2> ASYNC NEW_CORE C18 name=collection1 org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 92351 T10 C18 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92364 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@434256a5[collection1] main{StandardDirectoryReader(segments_4:101:nrt _16(4.10):C19 _17(4.10):C1 _18(4.10):C1 _19(4.10):C1 _1a(4.10):C1)}
[junit4] 2> 92365 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 92365 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@434256a5[collection1] main{StandardDirectoryReader(segments_4:101:nrt _16(4.10):C19 _17(4.10):C1 _18(4.10):C1 _19(4.10):C1 _1a(4.10):C1)}
[junit4] 2> 92365 T10 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 21
[junit4] 2> 92367 T10 C18 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=23 status=0 QTime=1
[junit4] 2> 92373 T10 C18 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false}
[junit4] 2> 92377 T10 C18 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher
[junit4] 2> 92378 T10 C18 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92378 T10 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=true&waitSearcher=true} {commit=} 0 5
[junit4] 2> 92379 T10 C18 oasc.SolrCore.execute [collection1] webapp=null path=/select params={q=*%3A*&rows=2147483647} hits=23 status=0 QTime=0
[junit4] 2> 92382 T10 oas.SolrTestCaseJ4.tearDown ###Ending testSolrCellDocumentTypes2
[junit4] 2> 92396 T10 oas.SolrTestCaseJ4.setUp ###Starting testTransformValue
[junit4] 2> 92399 T10 C18 oass.SolrIndexSearcher.<init> Opening Searcher@7633d3ee[collection1] realtime
[junit4] 2> 92399 T10 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={} {deleteByQuery=*:* (-1472004656489037824)} 0 3
[junit4] 2> 92401 T10 C18 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false}
[junit4] 2> 92405 T10 C18 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_4,generation=4}
[junit4] 2> commit{dir=MockDirectoryWrapper(RAMDirectory@330f400e lockFactory=NativeFSLockFactory@/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index),segFN=segments_5,generation=5}
[junit4] 2> 92405 T10 C18 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5
[junit4] 2> 92406 T10 C18 oass.SolrIndexSearcher.<init> Opening Searcher@4bec9999[collection1] main
[junit4] 2> 92407 T10 C18 oasu.DirectUpdateHandler2.commit end_commit_flush
[junit4] 2> 92407 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener sending requests to Searcher@4bec9999[collection1] main{StandardDirectoryReader(segments_4:103:nrt)}
[junit4] 2> 92410 T12 oasc.QuerySenderListener.newSearcher QuerySenderListener done.
[junit4] 2> 92410 T12 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4bec9999[collection1] main{StandardDirectoryReader(segments_4:103:nrt)}
[junit4] 2> 92412 T10 C18 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=/update params={commit=true&softCommit=false&waitSearcher=true} {commit=} 0 11
[junit4] 2> 92428 T10 oas.SolrTestCaseJ4.tearDown ###Ending testTransformValue
[junit4] 2> 92435 T10 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> 92436 T10 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1646630436
[junit4] 2> 92441 T10 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@5fda4526
[junit4] 2> 92444 T10 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=56,autocommit maxTime=60000ms,autocommits=0,soft autocommit maxTime=1000ms,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=61,cumulative_deletesById=0,cumulative_deletesByQuery=9,cumulative_errors=0,transaction_logs_total_size=125736,transaction_logs_total_number=9}
[junit4] 2> 92444 T10 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState
[junit4] 2> 92446 T10 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter
[junit4] 2> 92447 T10 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser
[junit4] 2> 92452 T10 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 92452 T10 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked
[junit4] 2> 92454 T10 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001 [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001;done=false>>]
[junit4] 2> 92454 T10 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001
[junit4] 2> 92454 T10 oasc.CachingDirectoryFactory.closeCacheValue looking to close /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index [CachedDir<<refCount=0;path=/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index;done=false>>]
[junit4] 2> 92455 T10 oasc.CachingDirectoryFactory.close Closing directory: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001/init-core-data-001/index
[junit4] 2> NOTE: leaving temporary files on disk at: /Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build/contrib/solr-morphlines-cell/test/J0/./solr.morphlines.cell.SolrCellMorphlineTest-528B56833D4FE9B8-001
[junit4] 2> NOTE: test params are: codec=Asserting(Lucene49), sim=DefaultSimilarity, locale=tr, timezone=Asia/Ashkhabad
[junit4] 2> NOTE: Mac OS X 10.8.5 x86_64/Oracle Corporation 1.7.0_60 (64-bit)/cpus=2,threads=1,free=101779496,total=199069696
[junit4] 2> NOTE: All tests run in this JVM: [SolrCellMorphlineTest]
[junit4] Completed in 93.10s, 5 tests, 1 failure <<< FAILURES!
[...truncated 9 lines...]
BUILD FAILED
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:467: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:447: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/build.xml:45: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/extra-targets.xml:37: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/build.xml:209: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/common-build.xml:440: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/solr/common-build.xml:496: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common-build.xml:1297: The following error occurred while executing this line:
/Users/jenkins/workspace/Lucene-Solr-4.x-MacOSX/lucene/common-build.xml:921: There were test failures: 1 suite, 5 tests, 1 failure
Total time: 138 minutes 31 seconds
Build step 'Invoke Ant' marked build as failure
Description set: Java: 64bit/jdk1.7.0 -XX:-UseCompressedOops -XX:+UseSerialGC
Archiving artifacts
Recording test results
Email was triggered for: Failure - Any
Sending email for trigger: Failure - Any