Build: http://jenkins.thetaphi.de/job/Lucene-Solr-trunk-Windows/4492/ Java: 32bit/jdk1.8.0_40-ea-b09 -server -XX:+UseConcMarkSweepGC (asserts: false)
2 tests failed. FAILED: org.apache.solr.cloud.TestModifyConfFiles.testDistribSearch Error Message: expected:<[Error from server at https://127.0.0.1:55984/ut/g/collection1: ]No file name specifi...> but was:<[]No file name specifi...> Stack Trace: org.junit.ComparisonFailure: expected:<[Error from server at https://127.0.0.1:55984/ut/g/collection1: ]No file name specifi...> but was:<[]No file name specifi...> at __randomizedtesting.SeedInfo.seed([7B191D48C311C66A:FAFF9350B44EA656]:0) at org.junit.Assert.assertEquals(Assert.java:125) at org.junit.Assert.assertEquals(Assert.java:147) at org.apache.solr.cloud.TestModifyConfFiles.doTest(TestModifyConfFiles.java:65) at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) at sun.reflect.GeneratedMethodAccessor35.invoke(Unknown Source) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:497) 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.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:365) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) 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:54) 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:365) at java.lang.Thread.run(Thread.java:745) FAILED: junit.framework.TestSuite.org.apache.solr.update.DirectUpdateHandlerTest Error Message: Suite timeout exceeded (>= 7200000 msec). Stack Trace: java.lang.Exception: Suite timeout exceeded (>= 7200000 msec). at __randomizedtesting.SeedInfo.seed([7B191D48C311C66A]:0) Build Log: [...truncated 9102 lines...] [junit4] Suite: org.apache.solr.update.DirectUpdateHandlerTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001 [junit4] 2> 1057996 T2630 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (true) [junit4] 2> 1057997 T2630 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 1057998 T2630 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 1057999 T2630 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1057999 T2630 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1057999 T2630 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1058044 T2630 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1058063 T2630 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1058064 T2630 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1\conf\schema12.xml [junit4] 2> 1058068 T2630 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 1058144 T2630 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1058145 T2630 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1058145 T2630 oass.IndexSchema.loadCopyFields WARN Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 1058153 T2630 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1058155 T2630 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1058158 T2630 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 1058158 T2630 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr [junit4] 2> 1058158 T2630 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\' [junit4] 2> 1058179 T2630 oasc.CoreContainer.<init> New CoreContainer 27800103 [junit4] 2> 1058179 T2630 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\] [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting maxConnections to: 10000 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 1058180 T2630 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 1058180 T2630 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false [junit4] 2> 1058180 T2630 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 1058180 T2630 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 1058180 T2630 oasc.CoreContainer.load Host Name: [junit4] 2> 1058183 T2631 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/' [junit4] 2> 1058185 T2631 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 1058186 T2631 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 1058186 T2631 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-trunk-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 1058222 T2631 oasc.SolrConfig.<init> Using Lucene MatchVersion: 6.0.0 [junit4] 2> 1058244 T2631 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 1058244 T2631 oass.IndexSchema.readSchema Reading Solr Schema from C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/conf\schema12.xml [junit4] 2> 1058249 T2631 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 1058326 T2631 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 1058327 T2631 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 1058329 T2631 oass.IndexSchema.loadCopyFields WARN Field text is not multivalued and destination for multiple copyFields (2) [junit4] 2> 1058337 T2631 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1058339 T2631 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 1058340 T2631 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/ [junit4] 2> 1058340 T2631 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockFSDirectoryFactory [junit4] 2> 1058341 T2631 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\core\src\test-files\solr\collection1/, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\ [junit4] 2> 1058341 T2631 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@b5b0e2 [junit4] 2> 1058343 T2631 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001 [junit4] 2> 1058343 T2631 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index/ [junit4] 2> 1058343 T2631 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index' doesn't exist. Creating new index... [junit4] 2> 1058346 T2631 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index [junit4] 2> 1058348 T2631 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_1,generation=1} [junit4] 2> 1058348 T2631 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1058350 T2631 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter [junit4] 2> 1058351 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 1058351 T2631 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 1058351 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1058351 T2631 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 1058352 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 1058352 T2631 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 1058352 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 1058352 T2631 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 1058352 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 1058353 T2631 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1058353 T2631 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 1058353 T2631 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /config: org.apache.solr.handler.SolrConfigHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /schema: org.apache.solr.handler.SchemaHandler [junit4] 2> 1058354 T2631 oasc.RequestHandlers.initHandlersFromConfig created /replication: org.apache.solr.handler.ReplicationHandler [junit4] 2> 1058355 T2631 oasc.RequestHandlers.initHandlersFromConfig created /get: org.apache.solr.handler.RealTimeGetHandler [junit4] 2> 1058355 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/luke: org.apache.solr.handler.admin.LukeRequestHandler [junit4] 2> 1058356 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/system: org.apache.solr.handler.admin.SystemInfoHandler [junit4] 2> 1058356 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/mbeans: org.apache.solr.handler.admin.SolrInfoMBeanHandler [junit4] 2> 1058356 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/plugins: org.apache.solr.handler.admin.PluginInfoHandler [junit4] 2> 1058357 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/threads: org.apache.solr.handler.admin.ThreadDumpHandler [junit4] 2> 1058357 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/properties: org.apache.solr.handler.admin.PropertiesRequestHandler [junit4] 2> 1058357 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/logging: org.apache.solr.handler.admin.LoggingHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/ping: org.apache.solr.handler.PingRequestHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 1058358 T2631 oasc.RequestHandlers.initHandlersFromConfig created /admin/fileedit: solr.admin.EditFileRequestHandler [junit4] 2> 1058359 T2631 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler [junit4] 2> 1058359 T2631 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler [junit4] 2> 1058359 T2631 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler [junit4] 2> 1058360 T2631 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058360 T2631 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058360 T2631 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler [junit4] 2> 1058361 T2631 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-def: solr.SearchHandler [junit4] 2> 1058362 T2631 oasc.RequestHandlers.initHandlersFromConfig created /search-facet-invariants: solr.SearchHandler [junit4] 2> 1058367 T2631 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1058368 T2631 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1058369 T2631 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1058370 T2631 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 1058370 T2631 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 1058372 T2631 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 1058372 T2631 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 1058372 T2631 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_1,generation=1} [junit4] 2> 1058372 T2631 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 1058373 T2631 oass.SolrIndexSearcher.<init> Opening Searcher@175595f[collection1] main [junit4] 2> 1058374 T2631 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 1058374 T2631 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 1058374 T2631 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed [junit4] 2> 1058374 T2631 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage [junit4] 2> 1058374 T2631 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 1058374 T2631 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 1058387 T2631 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 1058439 T2631 oash.ReplicationHandler.inform Commits will be reserved for 10000 [junit4] 2> 1058440 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@175595f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058440 T2631 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 1058442 T2630 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 1058444 T2630 oas.SolrTestCaseJ4.setUp ###Starting testPrepareCommit [junit4] 2> ASYNC NEW_CORE C2271 name=collection1 org.apache.solr.core.SolrCore@11b35ea [junit4] 2> 1058444 T2630 C2271 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058446 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 2 [junit4] 2> 1058447 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058452 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_1,generation=1} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_2,generation=2} [junit4] 2> 1058453 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 1058454 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@38f9f2[collection1] main [junit4] 2> 1058454 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058456 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@38f9f2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058456 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 9 [junit4] 2> 1058459 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[999]} 0 3 [junit4] 2> 1058460 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=true,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058474 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_2,generation=2} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_3,generation=3} [junit4] 2> 1058474 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 1058477 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@1a80ec2[collection1] main [junit4] 2> 1058477 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058481 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a80ec2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))} [junit4] 2> 1058481 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {optimize=} 0 21 [junit4] 2> 1058482 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058482 T2630 C2271 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 1058483 T2630 C2271 oasc.SolrCore.openNewSearcher SolrIndexSearcher has not changed - not re-opening: org.apache.solr.search.SolrIndexSearcher [junit4] 2> 1058483 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058484 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 2 [junit4] 2> 1058485 T2630 oasu.DirectUpdateHandlerTest.testPrepareCommit FILES before addDoc=[segments_3, _0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene50_0.tip] [junit4] 2> 1058489 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 4 [junit4] 2> 1058489 T2630 oasu.DirectUpdateHandlerTest.testPrepareCommit FILES before prepareCommit=[segments_3, _0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene50_0.tip, _1.fdt, _1.fdx] [junit4] 2> 1058491 T2630 C2271 oasu.DirectUpdateHandler2.prepareCommit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=true} [junit4] 2> 1058502 T2630 C2271 oasu.DirectUpdateHandler2.prepareCommit end_prepareCommit [junit4] 2> 1058502 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={prepareCommit=true&wt=json&indent=true} {commit=} 0 13 [junit4] 2> 1058502 T2630 oasu.DirectUpdateHandlerTest.testPrepareCommit FILES after prepareCommit=[pending_segments_4, segments_3, _0.fdt, _0.fdx, _0.fnm, _0.nvd, _0.nvm, _0.si, _0_Lucene50_0.doc, _0_Lucene50_0.tim, _0_Lucene50_0.tip, _1.fdt, _1.fdx, _1.fnm, _1.nvd, _1.nvm, _1.si, _1_Lucene50_0.doc, _1_Lucene50_0.tim, _1_Lucene50_0.tip] [junit4] 2> 1058506 T2630 C2271 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=0 status=0 QTime=1 [junit4] 2> 1058506 T2630 C2271 oasu.DirectUpdateHandler2.rollback start rollback{} [junit4] 2> 1058506 T2630 C2271 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter... [junit4] 2> 1058506 T2630 C2271 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1 [junit4] 2> 1058506 T2630 C2271 oasu.DefaultSolrCoreState.newIndexWriter Rollback old IndexWriter... core=collection1 [junit4] 2> 1058513 T2630 C2271 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_3,generation=3} [junit4] 2> 1058514 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 1058514 T2630 C2271 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used. [junit4] 2> 1058514 T2630 C2271 oasu.DirectUpdateHandler2.rollback end_rollback [junit4] 2> 1058515 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={rollback=true&wt=json&indent=true} {rollback=} 0 9 [junit4] 2> 1058515 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058516 T2630 C2271 oasu.DirectUpdateHandler2.commit No uncommitted changes. Skipping IW.commit. [junit4] 2> 1058519 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@1a6aeed[collection1] main [junit4] 2> 1058520 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058520 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a6aeed[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1)))} [junit4] 2> 1058521 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6 [junit4] 2> 1058526 T2630 C2271 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=0 status=0 QTime=4 [junit4] 2> 1058527 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 1 [junit4] 2> 1058527 T2630 C2271 oasu.DirectUpdateHandler2.prepareCommit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=true} [junit4] 2> 1058536 T2630 C2271 oasu.DirectUpdateHandler2.prepareCommit end_prepareCommit [junit4] 2> 1058536 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={prepareCommit=true&wt=json&indent=true} {commit=} 0 9 [junit4] 2> 1058537 T2630 C2271 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=0 status=0 QTime=1 [junit4] 2> 1058537 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058538 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_3,generation=3} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_4,generation=4} [junit4] 2> 1058538 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4 [junit4] 2> 1058541 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@15185b5[collection1] main [junit4] 2> 1058543 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058544 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15185b5[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_0(6.0.0):C1) Uninverting(_1(6.0.0):C1)))} [junit4] 2> 1058545 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8 [junit4] 2> 1058546 T2630 C2271 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:1&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1058546 T2630 oas.SolrTestCaseJ4.tearDown ###Ending testPrepareCommit [junit4] 2> 1058549 T2630 oas.SolrTestCaseJ4.setUp ###Starting testExpungeDeletes [junit4] 2> 1058549 T2630 C2271 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058549 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0 [junit4] 2> 1058550 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058552 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_4,generation=4} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_5,generation=5} [junit4] 2> 1058552 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 5 [junit4] 2> 1058554 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@b36d17[collection1] main [junit4] 2> 1058555 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@b36d17[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058555 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058558 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8 [junit4] 2> 1058561 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 3 [junit4] 2> 1058562 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2]} 0 0 [junit4] 2> 1058562 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058571 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_5,generation=5} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_6,generation=6} [junit4] 2> 1058571 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 6 [junit4] 2> 1058574 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@164d9a8[collection1] main [junit4] 2> 1058575 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@164d9a8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C2)))} [junit4] 2> 1058576 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058576 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14 [junit4] 2> 1058577 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[3]} 0 1 [junit4] 2> 1058578 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[2]} 0 0 [junit4] 2> 1058579 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[4]} 0 0 [junit4] 2> 1058579 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058590 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_6,generation=6} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_7,generation=7} [junit4] 2> 1058590 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 7 [junit4] 2> 1058591 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@40fb2f[collection1] main [junit4] 2> 1058595 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@40fb2f[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_2(6.0.0):C2/1:delGen=1) Uninverting(_3(6.0.0):C3)))} [junit4] 2> 1058596 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058596 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 17 [junit4] 2> 1058597 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=true,softCommit=false,prepareCommit=false} [junit4] 2> 1058612 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_7,generation=7} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_8,generation=8} [junit4] 2> 1058612 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 8 [junit4] 2> 1058616 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@1a620d2[collection1] main [junit4] 2> 1058617 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a620d2[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_4(6.0.0):C1) Uninverting(_3(6.0.0):C3)))} [junit4] 2> 1058618 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058619 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 23 [junit4] 2> 1058620 T2630 oas.SolrTestCaseJ4.tearDown ###Ending testExpungeDeletes [junit4] 2> 1058622 T2630 oas.SolrTestCaseJ4.setUp ###Starting testPostSoftCommitEvents [junit4] 2> 1058623 T2630 C2271 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058623 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1 [junit4] 2> 1058624 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058625 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_8,generation=8} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_9,generation=9} [junit4] 2> 1058625 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 9 [junit4] 2> 1058626 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@c14e8[collection1] main [junit4] 2> 1058627 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c14e8[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058628 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058631 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 8 [junit4] 2> 1058632 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[999]} 0 0 [junit4] 2> 1058633 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=true,prepareCommit=false} [junit4] 2> 1058641 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@15bd31c[collection1] main [junit4] 2> 1058643 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@15bd31c[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_5(6.0.0):C1)))} [junit4] 2> 1058644 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058644 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 11 [junit4] 2> 1058645 T2630 oas.SolrTestCaseJ4.tearDown ###Ending testPostSoftCommitEvents [junit4] 2> 1058649 T2630 oas.SolrTestCaseJ4.setUp ###Starting testBasics [junit4] 2> 1058650 T2630 C2271 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058650 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1 [junit4] 2> 1058650 T2630 C2271 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058652 T2630 C2271 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_9,generation=9} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_a,generation=10} [junit4] 2> 1058652 T2630 C2271 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 10 [junit4] 2> 1058653 T2630 C2271 oass.SolrIndexSearcher.<init> Opening Searcher@190fbfb[collection1] main [junit4] 2> 1058654 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@190fbfb[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058654 T2630 C2271 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058656 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6 [junit4] 2> 1058658 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[5]} 0 1 [junit4] 2> 1058659 T2630 C2271 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[6]} 0 0 [junit4] 2> ASYNC NEW_CORE C2272 name=collection1 org.apache.solr.core.SolrCore@11b35ea [junit4] 2> 1058674 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:5&wt=xml} hits=0 status=0 QTime=1 [junit4] 2> 1058674 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:6&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1058675 T2630 C2272 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058684 T2630 C2272 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_a,generation=10} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_b,generation=11} [junit4] 2> 1058684 T2630 C2272 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 11 [junit4] 2> 1058686 T2630 C2272 oass.SolrIndexSearcher.<init> Opening Searcher@11636a3[collection1] main [junit4] 2> 1058688 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@11636a3[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):C2)))} [junit4] 2> 1058688 T2630 C2272 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058688 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 14 [junit4] 2> 1058689 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:5&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1058689 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:6&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1058690 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {delete=[5]} 0 0 [junit4] 2> 1058690 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:5&wt=xml} hits=1 status=0 QTime=0 [junit4] 2> 1058691 T2630 C2272 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058694 T2630 C2272 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_b,generation=11} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_c,generation=12} [junit4] 2> 1058694 T2630 C2272 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 12 [junit4] 2> 1058695 T2630 C2272 oass.SolrIndexSearcher.<init> Opening Searcher@c1f6ce[collection1] main [junit4] 2> 1058695 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c1f6ce[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader(Uninverting(_6(6.0.0):C2/1:delGen=1)))} [junit4] 2> 1058697 T2630 C2272 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058697 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 7 [junit4] 2> 1058698 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:5&wt=xml} hits=0 status=0 QTime=1 [junit4] 2> 1058699 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:6&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1058699 T2630 C2272 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058699 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0 [junit4] 2> 1058700 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:6&wt=xml} hits=1 status=0 QTime=1 [junit4] 2> 1058700 T2630 C2272 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058702 T2630 C2272 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_c,generation=12} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_d,generation=13} [junit4] 2> 1058702 T2630 C2272 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 13 [junit4] 2> 1058703 T2630 C2272 oass.SolrIndexSearcher.<init> Opening Searcher@e074e1[collection1] main [junit4] 2> 1058703 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@e074e1[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058704 T2630 C2272 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058706 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 6 [junit4] 2> 1058706 T2630 C2272 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:6&wt=xml} hits=0 status=0 QTime=0 [junit4] 2> 1058706 T2630 oas.SolrTestCaseJ4.tearDown ###Ending testBasics [junit4] 2> 1058713 T2630 oas.SolrTestCaseJ4.setUp ###Starting testRequireUniqueKey [junit4] 2> 1058713 T2630 C2272 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058713 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 0 [junit4] 2> 1058714 T2630 C2272 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058716 T2630 C2272 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_d,generation=13} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_e,generation=14} [junit4] 2> 1058716 T2630 C2272 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 14 [junit4] 2> 1058717 T2630 C2272 oass.SolrIndexSearcher.<init> Opening Searcher@c94d3b[collection1] main [junit4] 2> 1058718 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c94d3b[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058719 T2630 C2272 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058719 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5 [junit4] 2> 1058720 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {add=[1]} 0 0 [junit4] 2> 1058722 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {} 0 1 [junit4] 2> 1058722 T2630 C2272 oasc.SolrException.log Ignoring exception matching ignore_exception [junit4] 2> 1058722 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {} 0 0 [junit4] 2> 1058722 T2630 C2272 oasc.SolrException.log Ignoring exception matching id [junit4] 2> 1058723 T2630 oas.SolrTestCaseJ4.tearDown ###Ending testRequireUniqueKey [junit4] 2> 1058726 T2630 oas.SolrTestCaseJ4.setUp ###Starting testAddRollback [junit4] 2> 1058727 T2630 C2272 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4] 2> 1058727 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:*} 0 1 [junit4] 2> 1058727 T2630 C2272 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 1058729 T2630 C2272 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_e,generation=14} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(NIOFSDirectory@C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.update.DirectUpdateHandlerTest-7B191D48C311C66A-001\init-core-data-001\index lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@3d2c2f)),segFN=segments_f,generation=15} [junit4] 2> 1058730 T2630 C2272 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 15 [junit4] 2> 1058730 T2630 C2272 oass.SolrIndexSearcher.<init> Opening Searcher@7f0f65[collection1] main [junit4] 2> 1058731 T2632 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@7f0f65[collection1] main{ExitableDirectoryReader(UninvertingDirectoryReader())} [junit4] 2> 1058732 T2630 C2272 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 1058732 T2630 C2272 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {commit=} 0 5 [junit4] 2> 1058732 T2630 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 1058732 T2630 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=27800103 [junit4] 2> 1058733 T2630 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@11b35ea [junit4] 2> 1058733 T2630 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=16,autocommits=0,soft autocommits=0,optimizes=1,rollbacks=1,expungeDeletes=1,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=11,cumulative_deletesById=1,cumulative_deletesByQuery=7,cumulative_errors=0} [junit4] 2> 1058733 T2630 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 1058733 T2630 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 1058733 T2630 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 1058735 T2630 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 1058738 T2630 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo WARN Could not getStatistics on info bean org.apache.solr.handler.ReplicationHandler org.apache.solr.common.SolrException: openNewSearcher called on closed core [junit4] 2> at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1464) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1702) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1447) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1382) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.getIndexVersion(ReplicationHandler.java:558) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.getStatistics(ReplicationHandler.java:575) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:257) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.objectInstancesFromFilteredNamedObjects(DefaultMBeanServerInterceptor.java:1556) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryMBeansImpl(DefaultMBeanServerInterceptor.java:513) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:526) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:619) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120) [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1127) [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:117) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:365) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:640) [junit4] 2> at org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:142) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 1058741 T2630 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo WARN Could not getStatistics on info bean org.apache.solr.search.SolrIndexSearcher org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed [junit4] 2> at org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:273) [junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:326) [junit4] 2> at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119) [junit4] 2> at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119) [junit4] 2> at org.apache.solr.search.SolrIndexSearcher.getStatistics(SolrIndexSearcher.java:2241) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:257) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.objectInstancesFromFilteredNamedObjects(DefaultMBeanServerInterceptor.java:1556) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryMBeansImpl(DefaultMBeanServerInterceptor.java:513) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:526) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:619) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120) [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1127) [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:117) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:365) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:640) [junit4] 2> at org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:142) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 1058746 T2630 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo WARN Could not getStatistics on info bean org.apache.solr.handler.ReplicationHandler org.apache.solr.common.SolrException: openNewSearcher called on closed core [junit4] 2> at org.apache.solr.core.SolrCore.openNewSearcher(SolrCore.java:1464) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1702) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1447) [junit4] 2> at org.apache.solr.core.SolrCore.getSearcher(SolrCore.java:1382) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.getIndexVersion(ReplicationHandler.java:558) [junit4] 2> at org.apache.solr.handler.ReplicationHandler.getStatistics(ReplicationHandler.java:575) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:257) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:644) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttribute(JmxMBeanServer.java:678) [junit4] 2> at javax.management.AttributeValueExp.getAttribute(AttributeValueExp.java:163) [junit4] 2> at javax.management.AttributeValueExp.apply(AttributeValueExp.java:105) [junit4] 2> at javax.management.BinaryRelQueryExp.apply(BinaryRelQueryExp.java:109) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.filterListOfObjectInstances(DefaultMBeanServerInterceptor.java:1626) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:546) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:619) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120) [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1127) [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:117) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:365) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:640) [junit4] 2> at org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:142) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 1058751 T2630 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo WARN Could not getStatistics on info bean org.apache.solr.search.SolrIndexSearcher org.apache.lucene.store.AlreadyClosedException: this IndexReader is closed [junit4] 2> at org.apache.lucene.index.IndexReader.ensureOpen(IndexReader.java:273) [junit4] 2> at org.apache.lucene.index.StandardDirectoryReader.getVersion(StandardDirectoryReader.java:326) [junit4] 2> at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119) [junit4] 2> at org.apache.lucene.index.FilterDirectoryReader.getVersion(FilterDirectoryReader.java:119) [junit4] 2> at org.apache.solr.search.SolrIndexSearcher.getStatistics(SolrIndexSearcher.java:2241) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo(JmxMonitoredMap.java:257) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getClassName(DefaultMBeanServerInterceptor.java:1804) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.safeGetClassName(DefaultMBeanServerInterceptor.java:1595) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.checkMBeanPermission(DefaultMBeanServerInterceptor.java:1813) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.getAttribute(DefaultMBeanServerInterceptor.java:644) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.getAttribute(JmxMBeanServer.java:678) [junit4] 2> at javax.management.AttributeValueExp.getAttribute(AttributeValueExp.java:163) [junit4] 2> at javax.management.AttributeValueExp.apply(AttributeValueExp.java:105) [junit4] 2> at javax.management.BinaryRelQueryExp.apply(BinaryRelQueryExp.java:109) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.filterListOfObjectInstances(DefaultMBeanServerInterceptor.java:1626) [junit4] 2> at com.sun.jmx.interceptor.DefaultMBeanServerInterceptor.queryNames(DefaultMBeanServerInterceptor.java:546) [junit4] 2> at com.sun.jmx.mbeanserver.JmxMBeanServer.queryNames(JmxMBeanServer.java:619) [junit4] 2> at org.apache.solr.core.JmxMonitoredMap.clear(JmxMonitoredMap.java:120) [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1127) [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:117) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:365) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:640) [junit4] 2> at org.apache.solr.update.DirectUpdateHandlerTest.testAddRollback(DirectUpdateHandlerTest.java:142) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:497) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:827) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:863) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:877) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:49) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:798) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:458) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:836) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:738) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:772) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:783) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:46) [junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:54) [junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 1058754 T2630 oasc.JmxMonitoredMap$SolrDynamicMBean.getMBeanInfo WARN Could not getStati [...truncated too long message...] nit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) [junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 9857608 T7432 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 9857608 T7432 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\index;done=false>>] [junit4] 2> 9857608 T7432 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\index [junit4] 2> 9857608 T7432 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\;done=false>>] [junit4] 2> 9857608 T7432 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001\tempDir-001/jetty4\ [junit4] 2> 9857612 T7432 oasc.Overseer.close Overseer (id=92974663155122190-127.0.0.1:56012_ut%2Fg-n_0000000004) closing [junit4] 2> 9857612 T7580 oasc.Overseer$ClusterStateUpdater.run Overseer Loop exiting : 127.0.0.1:56012_ut%2Fg [junit4] 2> 9857617 T7434 oazs.NIOServerCnxn.doIO WARN caught end of stream exception EndOfStreamException: Unable to read additional data from client sessionid 0x14a4ff6aa79000e, likely client has closed socket [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxn.doIO(NIOServerCnxn.java:228) [junit4] 2> at org.apache.zookeeper.server.NIOServerCnxnFactory.run(NIOServerCnxnFactory.java:208) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> [junit4] 2> 9859115 T7553 oascc.ZkStateReader$7.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK [junit4] 2> 9859115 T7575 oascc.ZkStateReader$3.process WARN ZooKeeper watch triggered, but Solr cannot talk to ZK [junit4] 2> 9859133 T7432 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/ut/g,null} [junit4] 2> 9864120 T7432 oas.SolrTestCaseJ4.tearDown ###Ending testDistribSearch [junit4] 2> 9864124 T7432 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:55959 55959 [junit4] 2> 9866380 T7433 oasc.ZkTestServer.send4LetterWord connecting to 127.0.0.1:55959 55959 [junit4] 2> 9866383 T7433 oasc.ZkTestServer$ZKServerMain.runFromConfig WARN Watch limit violations: [junit4] 2> Maximum concurrent create/delete watches above limit: [junit4] 2> [junit4] 2> 6 /solr/aliases.json [junit4] 2> 6 /solr/clusterstate.json [junit4] 2> 5 /solr/configs/conf1 [junit4] 2> 4 /solr/collections/collection1/state.json [junit4] 2> [junit4] 2> Maximum concurrent children watches above limit: [junit4] 2> [junit4] 2> 6 /solr/live_nodes [junit4] 2> 5 /solr/overseer/collection-queue-work [junit4] 2> 4 /solr/overseer/queue [junit4] 2> [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestModifyConfFiles -Dtests.method=testDistribSearch -Dtests.seed=7B191D48C311C66A -Dtests.slow=true -Dtests.locale=zh -Dtests.timezone=MIT -Dtests.asserts=false -Dtests.file.encoding=US-ASCII [junit4] FAILURE 55.0s | TestModifyConfFiles.testDistribSearch <<< [junit4] > Throwable #1: org.junit.ComparisonFailure: expected:<[Error from server at https://127.0.0.1:55984/ut/g/collection1: ]No file name specifi...> but was:<[]No file name specifi...> [junit4] > at __randomizedtesting.SeedInfo.seed([7B191D48C311C66A:FAFF9350B44EA656]:0) [junit4] > at org.apache.solr.cloud.TestModifyConfFiles.doTest(TestModifyConfFiles.java:65) [junit4] > at org.apache.solr.BaseDistributedSearchTestCase.testDistribSearch(BaseDistributedSearchTestCase.java:869) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] 2> 9866411 T7432 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> NOTE: leaving temporary files on disk at: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\temp\solr.cloud.TestModifyConfFiles-7B191D48C311C66A-001 [junit4] 2> NOTE: test params are: codec=Asserting(Lucene50): {}, docValues:{}, sim=DefaultSimilarity, locale=zh, timezone=MIT [junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.8.0_40-ea (32-bit)/cpus=2,threads=1,free=95044312,total=433111040 [junit4] 2> NOTE: All tests run in this JVM: [TestRangeQuery, TestDocBasedVersionConstraints, CollectionsAPIAsyncDistributedZkTest, ClusterStateTest, AliasIntegrationTest, TestDistributedSearch, DirectSolrSpellCheckerTest, TestSolrIndexConfig, BasicZkTest, TestRecoveryHdfs, TestManagedStopFilterFactory, TestCSVLoader, TestReplicaProperties, OverseerTest, TestFieldResource, SolrTestCaseJ4Test, WordBreakSolrSpellCheckerTest, DistributedSpellCheckComponentTest, TermVectorComponentTest, TestIndexingPerformance, DOMUtilTest, CacheHeaderTest, OutOfBoxZkACLAndCredentialsProvidersTest, TestStressRecovery, ExternalFileFieldSortTest, DistribCursorPagingTest, TestCloudPivotFacet, TestCoreContainer, UUIDUpdateProcessorFallbackTest, UniqFieldsUpdateProcessorFactoryTest, ModifyConfFileTest, AddBlockUpdateTest, TestHashPartitioner, HttpPartitionTest, TestFieldTypeCollectionResource, TestReplicationHandlerBackup, TestRealTimeGet, TestReRankQParserPlugin, ChangedSchemaMergeTest, HighlighterMaxOffsetTest, BasicDistributedZk2Test, TestRandomFaceting, TestSolrJ, TestSolrConfigHandler, TestSuggestSpellingConverter, IndexSchemaTest, SolrPluginUtilsTest, TestCustomSort, TestLMJelinekMercerSimilarityFactory, ReturnFieldsTest, DirectUpdateHandlerTest, TestReloadAndDeleteDocs, SolrCoreCheckLockOnStartupTest, TestCloudManagedSchema, TestChildDocTransformer, DirectUpdateHandlerOptimizeTest, DistributedQueryElevationComponentTest, FacetPivotSmallTest, DateFieldTest, TestQuerySenderNoQuery, BadCopyFieldTest, TestBulkSchemaAPI, AlternateDirectoryTest, LeaderElectionTest, BadComponentTest, CustomCollectionTest, TestDefaultSimilarityFactory, TestClassNameShortening, TestConfigReload, TestBlendedInfixSuggestions, SyncSliceTest, ZkSolrClientTest, TestMiniSolrCloudCluster, TestCollationFieldDocValues, TestBadConfig, TestCloudSchemaless, DistributedSuggestComponentTest, SimpleFacetsTest, SpatialFilterTest, DateMathParserTest, TermVectorComponentDistributedTest, ParsingFieldUpdateProcessorsTest, BasicFunctionalityTest, MultiThreadedOCPTest, TestExceedMaxTermLength, DistributedFacetPivotSmallAdvancedTest, LeaderInitiatedRecoveryOnCommitTest, PreAnalyzedFieldTest, TestQueryUtils, QueryEqualityTest, TestManagedSynonymFilterFactory, HighlighterConfigTest, CollectionsAPIDistributedZkTest, TestSchemaManager, TestRequestStatusCollectionAPI, LeaderFailoverAfterPartitionTest, SpellCheckComponentTest, UpdateParamsTest, CloudExitableDirectoryReaderTest, TestTrie, TestBinaryField, DistributedFacetPivotSmallTest, TestImplicitCoreProperties, TestRandomMergePolicy, TestBlobHandler, TestPseudoReturnFields, HighlighterTest, SuggesterTest, TestRecovery, DocValuesTest, TestModifyConfFiles] [junit4] Completed in 55.09s, 1 test, 1 failure <<< FAILURES! [...truncated 1083 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:519: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:467: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\build.xml:61: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:187: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\solr\common-build.xml:510: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1349: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:956: There were test failures: 452 suites, 1845 tests, 1 suite-level error, 1 failure, 56 ignored (31 assumptions) Total time: 263 minutes 48 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 32bit/jdk1.8.0_40-ea-b09 -server -XX:+UseConcMarkSweepGC (asserts: false) Archiving artifacts Recording test results Email was triggered for: Failure - Any Sending email for trigger: Failure - Any
--------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscr...@lucene.apache.org For additional commands, e-mail: dev-h...@lucene.apache.org
