Build: http://jenkins.thetaphi.de/job/Lucene-Solr-4.x-Windows/4188/ Java: 64bit/jdk1.8.0_20 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC
1 tests failed. FAILED: junit.framework.TestSuite.org.apache.solr.update.HardAutoCommitTest Error Message: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000000 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001 Stack Trace: java.io.IOException: Could not remove the following files (in the order of attempts): C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000000 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001 C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001 at __randomizedtesting.SeedInfo.seed([CFFBD97665B3FD4E]:0) at org.apache.lucene.util.TestUtil.rm(TestUtil.java:117) at org.apache.lucene.util.TestRuleTemporaryFilesCleanup.afterAlways(TestRuleTemporaryFilesCleanup.java:125) at com.carrotsearch.randomizedtesting.rules.TestRuleAdapter$1.afterAlways(TestRuleAdapter.java:31) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:43) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:65) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:365) at java.lang.Thread.run(Thread.java:745) Build Log: [...truncated 10987 lines...] [junit4] Suite: org.apache.solr.update.HardAutoCommitTest [junit4] 2> Creating dataDir: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001 [junit4] 2> 437258 T1227 oas.SolrTestCaseJ4.buildSSLConfig Randomized ssl (false) and clientAuth (false) [junit4] 2> 437259 T1227 oas.SolrTestCaseJ4.initCore ####initCore [junit4] 2> 437259 T1227 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1\' [junit4] 2> 437261 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 437261 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 437263 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 437312 T1227 oasc.SolrConfig.<init> Using Lucene MatchVersion: 4.11.0 [junit4] 2> 437330 T1227 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 437330 T1227 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 437334 T1227 oass.IndexSchema.readSchema [null] Schema name=test [junit4] 2> 437419 T1227 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437419 T1227 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437421 T1227 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 437427 T1227 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 437428 T1227 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 437434 T1227 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437437 T1227 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437439 T1227 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437439 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437439 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437439 T1227 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437441 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437441 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437441 T1227 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4] 2> 437441 T1227 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr [junit4] 2> 437442 T1227 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\' [junit4] 2> 437479 T1227 oasc.CoreContainer.<init> New CoreContainer 255032002 [junit4] 2> 437479 T1227 oasc.CoreContainer.load Loading cores into CoreContainer [instanceDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\] [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: null [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4] 2> 437480 T1227 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4] 2> 437480 T1227 oasu.UpdateShardHandler.<init> Creating UpdateShardHandler HTTP client with params: socketTimeout=30000&connTimeout=30000&retry=false [junit4] 2> 437480 T1227 oasl.LogWatcher.createWatcher SLF4J impl is org.slf4j.impl.Log4jLoggerFactory [junit4] 2> 437480 T1227 oasl.LogWatcher.newRegisteredLogWatcher Registering Log Listener [Log4j (org.slf4j.impl.Log4jLoggerFactory)] [junit4] 2> 437480 T1227 oasc.CoreContainer.load Host Name: [junit4] 2> 437484 T1228 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/' [junit4] 2> 437486 T1228 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 437486 T1228 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 437486 T1228 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 437512 T1228 oasc.SolrConfig.<init> Using Lucene MatchVersion: 4.11.0 [junit4] 2> 437529 T1228 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 437529 T1228 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 437533 T1228 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 437634 T1228 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437634 T1228 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437639 T1228 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 437647 T1228 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 437647 T1228 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 437658 T1228 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437660 T1228 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437669 T1228 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437669 T1228 oasc.CoreContainer.create Creating SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/ [junit4] 2> 437669 T1228 oasc.SolrCore.initDirectoryFactory org.apache.solr.core.MockDirectoryFactory [junit4] 2> 437671 T1228 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\ [junit4] 2> 437671 T1228 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4e70c99e [junit4] 2> 437677 T1228 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\ [junit4] 2> 437677 T1228 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index/ [junit4] 2> 437677 T1228 oasc.SolrCore.initIndex WARN [collection1] Solr index directory 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index' doesn't exist. Creating new index... [junit4] 2> 437678 T1228 oasc.CachingDirectoryFactory.get return new directory for C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index [junit4] 2> 437686 T1228 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.TieredMergePolicy: [TieredMergePolicy: maxMergeAtOnce=36, maxMergeAtOnceExplicit=41, maxMergedSegmentMB=7.8955078125, floorSegmentMB=1.7314453125, forceMergeDeletesPctAllowed=9.905406505342466, segmentsPerTier=35.0, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.0 [junit4] 2> 437696 T1228 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_1,generation=1} [junit4] 2> 437696 T1228 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 437698 T1228 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 437700 T1228 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 437701 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 437701 T1228 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead [junit4] 2> 437701 T1228 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params [junit4] 2> 437701 T1228 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 437701 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 437702 T1228 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 437704 T1228 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 437704 T1228 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 437704 T1228 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437705 T1228 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437705 T1228 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437705 T1228 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437705 T1228 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 437705 T1228 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 437706 T1228 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 437706 T1228 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 437706 T1228 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler [junit4] 2> 437707 T1228 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4] 2> 437707 T1228 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 437707 T1228 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437708 T1228 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437709 T1228 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437710 T1228 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437710 T1228 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437710 T1228 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437711 T1228 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler [junit4] 2> 437711 T1228 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler [junit4] 2> 437716 T1228 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437716 T1228 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437717 T1228 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437718 T1228 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437720 T1228 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437720 T1228 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 437723 T1228 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 437723 T1228 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 437729 T1228 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.MockRandomMergePolicy: org.apache.lucene.index.MockRandomMergePolicy@7fc5d025 [junit4] 2> 437729 T1228 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_1,generation=1} [junit4] 2> 437729 T1228 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 437730 T1228 oass.SolrIndexSearcher.<init> Opening Searcher@1fbfb050[collection1] main [junit4] 2> 437731 T1228 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 437731 T1228 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 437731 T1228 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed [junit4] 2> 437731 T1228 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage [junit4] 2> 437731 T1228 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 437731 T1228 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 437747 T1228 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 437787 T1228 oasc.CoreContainer.registerCore registering core: collection1 [junit4] 2> 437788 T1229 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1fbfb050[collection1] main{StandardDirectoryReader(segments_1:1:nrt)} [junit4] 2> 437791 T1227 oas.SolrTestCaseJ4.initCore ####initCore end [junit4] 2> 437793 T1227 oas.SolrTestCaseJ4.setUp ###Starting testCommitWithin [junit4] 2> ASYNC NEW_CORE C318 name=collection1 org.apache.solr.core.SolrCore@32035f5f [junit4] 2> 437796 T1227 C318 oasup.LogUpdateProcessor.finish [collection1] webapp=null path=null params={} {deleteByQuery=*:* (-1477882017226948608)} 0 3 [junit4] 2> 437798 T1227 oasc.SolrResourceLoader.<init> new SolrResourceLoader for directory: 'C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/' [junit4] 2> 437798 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/.svn/' to classloader [junit4] 2> 437798 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/classes/' to classloader [junit4] 2> 437798 T1227 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Users/JenkinsSlave/workspace/Lucene-Solr-4.x-Windows/solr/core/src/test-files/solr/collection1/lib/README' to classloader [junit4] 2> 437830 T1227 oasc.SolrConfig.<init> Using Lucene MatchVersion: 4.11.0 [junit4] 2> 437844 T1227 oasc.SolrConfig.<init> Loaded SolrConfig: solrconfig.xml [junit4] 2> 437847 T1227 oass.IndexSchema.readSchema Reading Solr Schema from schema.xml [junit4] 2> 437850 T1227 oass.IndexSchema.readSchema [collection1] Schema name=test [junit4] 2> 437939 T1227 oass.ByteField.init WARN ByteField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437941 T1227 oass.ShortField.init WARN ShortField is deprecated and will be removed in 5.0. You should use TrieIntField instead. [junit4] 2> 437942 T1227 oass.OpenExchangeRatesOrgProvider.init Initialized with rates=open-exchange-rates.json, refreshInterval=1440. [junit4] 2> 437945 T1227 oass.IndexSchema.readSchema default search field in schema is text [junit4] 2> 437945 T1227 oass.IndexSchema.readSchema unique key field: id [junit4] 2> 437951 T1227 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437954 T1227 oass.FileExchangeRateProvider.reload Reloading exchange rates from file currency.xml [junit4] 2> 437956 T1227 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437956 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437956 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437956 T1227 oass.OpenExchangeRatesOrgProvider.reload Reloading exchange rates from open-exchange-rates.json [junit4] 2> 437958 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Unknown key IMPORTANT NOTE [junit4] 2> 437958 T1227 oass.OpenExchangeRatesOrgProvider$OpenExchangeRates.<init> WARN Expected key, got STRING [junit4] 2> 437958 T1227 oasc.CoreContainer.reload Reloading SolrCore 'collection1' using configuration from instancedir C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/ [junit4] 2> 437958 T1227 oasc.SolrCore.<init> [collection1] Opening new SolrCore at C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\core\src\test-files\solr\collection1/, dataDir=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\ [junit4] 2> 437958 T1227 oasc.JmxMonitoredMap.<init> JMX monitoring is enabled. Adding Solr mbeans to JMX Server: com.sun.jmx.mbeanserver.JmxMBeanServer@4e70c99e [junit4] 2> 437959 T1227 oasc.SolrCore.getNewIndexDir New index directory detected: old=null new=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index/ [junit4] 2> 437960 T1227 oasc.SolrCore.initWriters created xml: solr.XMLResponseWriter [junit4] 2> 437963 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe" [junit4] 2> 437963 T1227 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe" [junit4] 2> 437963 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "dedupe-allfields" [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "stored_sig" [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "stored_sig" [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "uniq-fields" [junit4] 2> 437964 T1227 oasup.UniqFieldsUpdateProcessorFactory.init WARN Use of the 'fields' init param in UniqFieldsUpdateProcessorFactory is deprecated, please use 'fieldName' (or another FieldMutatingUpdateProcessorFactory selector option) instead [junit4] 2> 437964 T1227 oasup.UniqFieldsUpdateProcessorFactory.init Replacing 'fields' init param with (individual) 'fieldName' params [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "uniq-fields" [junit4] 2> 437964 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-explicit" [junit4] 2> 437965 T1227 oasup.UpdateRequestProcessorChain.init creating updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 437965 T1227 oasup.UpdateRequestProcessorChain.init inserting DistributedUpdateProcessorFactory into updateRequestProcessorChain "distrib-dup-test-chain-implicit" [junit4] 2> 437965 T1227 oasc.SolrCore.loadUpdateProcessorChains no updateRequestProcessorChain defined as default, creating implicit default [junit4] 2> 437967 T1227 oasc.RequestHandlers.initHandlersFromConfig created /update: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437967 T1227 oasc.RequestHandlers.initHandlersFromConfig created /update/json: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig created /update/csv: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig created /update/json/docs: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.ReplicationHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig created /replication: solr.ReplicationHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4] 2> 437968 T1227 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4] 2> 437969 T1227 oasc.RequestHandlers.initHandlersFromConfig created dismax: solr.SearchHandler [junit4] 2> 437969 T1227 oasc.RequestHandlers.initHandlersFromConfig created mock: org.apache.solr.core.MockQuerySenderListenerReqHandler [junit4] 2> 437970 T1227 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4] 2> 437970 T1227 oasc.RequestHandlers.initHandlersFromConfig created /admin/file: solr.admin.ShowFileRequestHandler [junit4] 2> 437971 T1227 oasc.RequestHandlers.initHandlersFromConfig created defaults: solr.StandardRequestHandler [junit4] 2> 437971 T1227 oasc.RequestHandlers.initHandlersFromConfig adding lazy requestHandler: solr.StandardRequestHandler [junit4] 2> 437971 T1227 oasc.RequestHandlers.initHandlersFromConfig created lazy: solr.StandardRequestHandler [junit4] 2> 437972 T1227 oasc.RequestHandlers.initHandlersFromConfig WARN Multiple requestHandler registered to the same name: /update ignoring: org.apache.solr.handler.UpdateRequestHandler [junit4] 2> 437972 T1227 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4] 2> 437972 T1227 oasc.RequestHandlers.initHandlersFromConfig created /terms: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437972 T1227 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437973 T1227 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437973 T1227 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437974 T1227 oasc.RequestHandlers.initHandlersFromConfig created spellCheckWithWordbreak_Direct: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437974 T1227 oasc.RequestHandlers.initHandlersFromConfig created spellCheckCompRH1: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437975 T1227 oasc.RequestHandlers.initHandlersFromConfig created mltrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437975 T1227 oasc.RequestHandlers.initHandlersFromConfig created tvrh: org.apache.solr.handler.component.SearchHandler [junit4] 2> 437976 T1227 oasc.RequestHandlers.initHandlersFromConfig created /mlt: solr.MoreLikeThisHandler [junit4] 2> 437976 T1227 oasc.RequestHandlers.initHandlersFromConfig created /debug/dump: solr.DumpRequestHandler [junit4] 2> 437977 T1227 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437978 T1227 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437980 T1227 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437980 T1227 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437982 T1227 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4] 2> 437982 T1227 oasc.SolrCore.initDeprecatedSupport WARN solrconfig.xml uses deprecated <admin/gettableFiles>, Please update your config to use the ShowFileRequestHandler. [junit4] 2> 437984 T1227 oasu.CommitTracker.<init> Hard AutoCommit: disabled [junit4] 2> 437984 T1227 oasu.CommitTracker.<init> Soft AutoCommit: disabled [junit4] 2> 437984 T1227 oass.SolrIndexSearcher.<init> Opening Searcher@4e38ffb7[collection1] main [junit4] 2> 437984 T1227 oasr.RestManager.init Initializing RestManager with initArgs: {storageIO=org.apache.solr.rest.ManagedResourceStorage$InMemoryStorageIO} [junit4] 2> 437984 T1227 oasr.ManagedResourceStorage.load Reading _rest_managed.json using InMemoryStorage [junit4] 2> 437984 T1227 oasr.ManagedResource.reloadFromStorage WARN No stored data found for /rest/managed [junit4] 2> 437984 T1227 oasr.ManagedResourceStorage$JsonStorage.store Saved JSON object to path _rest_managed.json using InMemoryStorage [junit4] 2> 437984 T1227 oasr.RestManager.init Initializing 0 registered ManagedResources [junit4] 2> 437984 T1227 oashc.SpellCheckComponent.inform Initializing spell checkers [junit4] 2> 437988 T1227 oass.DirectSolrSpellChecker.init init: {name=direct,classname=DirectSolrSpellChecker,field=lowerfilt,minQueryLength=3} [junit4] 2> 438000 T1227 oasu.DefaultSolrCoreState.newIndexWriter Creating new IndexWriter... [junit4] 2> 438000 T1227 oasu.DefaultSolrCoreState.newIndexWriter Waiting until IndexWriter is unused... core=collection1 [junit4] 2> 438000 T1227 oasu.DefaultSolrCoreState.closeIndexWriter Closing old IndexWriter... core=collection1 [junit4] 2> 438004 T1231 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4e38ffb7[collection1] main{StandardDirectoryReader(segments_1:1:nrt)} [junit4] 2> 438005 T1227 oasu.RandomMergePolicy.<init> RandomMergePolicy wrapping class org.apache.lucene.index.LogDocMergePolicy: [LogDocMergePolicy: minMergeSize=1000, mergeFactor=31, maxMergeSize=9223372036854775807, maxMergeSizeForForcedMerge=9223372036854775807, calibrateSizeByDeletes=false, maxMergeDocs=2147483647, maxCFSSegmentSizeMB=8.796093022207999E12, noCFSRatio=0.4906456288282234] [junit4] 2> 438006 T1227 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits: num=1 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_1,generation=1} [junit4] 2> 438007 T1227 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 1 [junit4] 2> 438007 T1227 oasu.DefaultSolrCoreState.newIndexWriter New IndexWriter is ready to be used. [junit4] 2> 438007 T1227 oass.SolrIndexSearcher.<init> Opening Searcher@4a3a4f95[collection1] main [junit4] 2> 438008 T1231 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@4a3a4f95[collection1] main{StandardDirectoryReader(segments_1:1:nrt)} [junit4] 2> 438009 T1227 oasc.CoreContainer.registerCore replacing core: collection1 [junit4] 2> 438009 T1227 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@32035f5f [junit4] 2> 438013 T1227 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=1,errors=0,cumulative_adds=0,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0,transaction_logs_total_size=0,transaction_logs_total_number=0} [junit4] 2> 438014 T1227 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 438021 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[529 (1477882017464975360)]} 0 4 [junit4] 2> ASYNC NEW_CORE C319 name=collection1 org.apache.solr.core.SolrCore@1a48d3bd [junit4] 2> 438022 T1227 C319 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1 [junit4] 2> 439679 T1232 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 439680 T1232 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_1,generation=1} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_2,generation=2} [junit4] 2> 439680 T1232 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 2 [junit4] 2> 439684 T1232 oass.SolrIndexSearcher.<init> Opening Searcher@1b5c726d[collection1] main [junit4] 2> 439686 T1231 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1b5c726d[collection1] main{StandardDirectoryReader(segments_2:3:nrt _0(4.11.0):c1)} [junit4] 2> 439690 T1232 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 439909 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[530 (1477882019442589696)]} 0 4 [junit4] 2> 439909 T1227 C319 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 439910 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[529 (-1477882019446784000)]} 0 4 [junit4] 2> 439910 T1227 C319 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 440813 T1232 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 440821 T1232 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_2,generation=2} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_3,generation=3} [junit4] 2> 440821 T1232 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 3 [junit4] 2> 440823 T1232 oass.SolrIndexSearcher.<init> Opening Searcher@5bb94e07[collection1] main [junit4] 2> 440826 T1232 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4] 2> 440827 T1231 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@5bb94e07[collection1] main{StandardDirectoryReader(segments_3:7:nrt _1(4.11.0):c1)} [junit4] 2> ASYNC NEW_CORE C320 name=collection1 org.apache.solr.core.SolrCore@1a48d3bd [junit4] 2> 441047 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:529&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 441048 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=1 [junit4] 2> 441050 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020641112064)]} 0 4 [junit4] 2> 441057 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020643209216)]} 0 4 [junit4] 2> 441057 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020649500672)]} 0 4 [junit4] 2> 441057 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020649500673)]} 0 4 [junit4] 2> 441057 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020649500674)]} 0 4 [junit4] 2> 441057 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020649500675)]} 0 4 [junit4] 2> 441058 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020650549248)]} 0 4 [junit4] 2> 441058 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020650549249)]} 0 4 [junit4] 2> 441059 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020650549250)]} 0 4 [junit4] 2> 441059 T1227 oasup.LogUpdateProcessor.finish [collection1] {add=[500 (1477882020651597824)]} 0 4 [junit4] 2> 441059 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=0 [junit4] 2> 441063 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020653694976)]} 0 4 [junit4] 2> 441063 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020655792128)]} 0 4 [junit4] 2> 441063 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020655792129)]} 0 4 [junit4] 2> 441064 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020656840704)]} 0 4 [junit4] 2> 441064 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020656840705)]} 0 4 [junit4] 2> 441064 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020656840706)]} 0 4 [junit4] 2> 441065 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020657889280)]} 0 4 [junit4] 2> 441065 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020657889281)]} 0 4 [junit4] 2> 441065 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020657889282)]} 0 4 [junit4] 2> 441065 T1227 oasup.LogUpdateProcessor.finish [collection1] {delete=[530 (-1477882020657889283)]} 0 4 [junit4] 2> 441065 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=0 [junit4] 2> 441966 T1232 oasu.DirectUpdateHandler2.commit start commit{,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false,prepareCommit=false} [junit4] 2> 441967 T1232 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits: num=2 [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_3,generation=3} [junit4] 2> commit{dir=RateLimitedDirectoryWrapper(MockDirectoryWrapper(RAMDirectory@319c8607 lockFactory=org.apache.lucene.store.SingleInstanceLockFactory@7987ec49)),segFN=segments_4,generation=4} [junit4] 2> 441967 T1232 oasc.SolrDeletionPolicy.updateCommits newest commit generation = 4 [junit4] 2> 441970 T1232 oass.SolrIndexSearcher.<init> Opening Searcher@34cecad6[collection1] main [junit4] 2> 441971 T1231 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@34cecad6[collection1] main{StandardDirectoryReader(segments_4:11:nrt _2(4.11.0):c10/9:delGen=1)} [junit4] 2> 441975 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:500&qt=standard&start=0&rows=20&version=2.2} hits=1 status=0 QTime=1 [junit4] 2> 441976 T1227 C320 oasc.SolrCore.execute [collection1] webapp=null path=null params={q=id:530&qt=standard&start=0&rows=20&version=2.2} hits=0 status=0 QTime=1 [junit4] 2> 441976 T1227 oas.SolrTestCaseJ4.tearDown ###Ending testCommitWithin [junit4] 2> 441976 T1227 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4] 2> 441976 T1227 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=255032002 [junit4] 2> 441979 T1227 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1a48d3bd [junit4] 2> 441992 T1227 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=3,autocommits=3,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=10,deletesById=10,deletesByQuery=0,errors=0,cumulative_adds=12,cumulative_deletesById=11,cumulative_deletesByQuery=0,cumulative_errors=0,transaction_logs_total_size=310,transaction_logs_total_number=2} [junit4] 2> 442017 T1227 oasu.SolrCoreState.decrefSolrCoreState Closing SolrCoreState [junit4] 2> 442017 T1227 oasu.DefaultSolrCoreState.closeIndexWriter SolrCoreState ref count has reached 0 - closing IndexWriter [junit4] 2> 442017 T1227 oasu.DefaultSolrCoreState.closeIndexWriter closing IndexWriter with IndexWriterCloser [junit4] 2> 442020 T1232 oasc.SolrException.log ERROR auto commit error...:org.apache.solr.common.SolrException: java.nio.channels.ClosedByInterruptException [junit4] 2> at org.apache.solr.update.TransactionLog.writeCommit(TransactionLog.java:458) [junit4] 2> at org.apache.solr.update.UpdateLog.postCommit(UpdateLog.java:629) [junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.commit(DirectUpdateHandler2.java:623) [junit4] 2> at org.apache.solr.update.CommitTracker.run(CommitTracker.java:216) [junit4] 2> at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:511) [junit4] 2> at java.util.concurrent.FutureTask.run(FutureTask.java:266) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$201(ScheduledThreadPoolExecutor.java:180) [junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1142) [junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:617) [junit4] 2> at java.lang.Thread.run(Thread.java:745) [junit4] 2> Caused by: java.nio.channels.ClosedByInterruptException [junit4] 2> at java.nio.channels.spi.AbstractInterruptibleChannel.end(AbstractInterruptibleChannel.java:202) [junit4] 2> at sun.nio.ch.FileChannelImpl.write(FileChannelImpl.java:215) [junit4] 2> at java.nio.channels.Channels.writeFullyImpl(Channels.java:78) [junit4] 2> at java.nio.channels.Channels.writeFully(Channels.java:101) [junit4] 2> at java.nio.channels.Channels.access$000(Channels.java:61) [junit4] 2> at java.nio.channels.Channels$1.write(Channels.java:174) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:214) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:207) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:191) [junit4] 2> at org.apache.solr.update.TransactionLog.writeCommit(TransactionLog.java:453) [junit4] 2> ... 10 more [junit4] 2> [junit4] 2> 442021 T1227 C320 oasu.DirectUpdateHandler2.closeWriter ERROR Error closing log files org.apache.solr.common.SolrException: java.nio.channels.ClosedChannelException [junit4] 2> at org.apache.solr.update.TransactionLog.close(TransactionLog.java:549) [junit4] 2> at org.apache.solr.update.TransactionLog.decref(TransactionLog.java:504) [junit4] 2> at org.apache.solr.update.UpdateLog.doClose(UpdateLog.java:842) [junit4] 2> at org.apache.solr.update.UpdateLog.close(UpdateLog.java:861) [junit4] 2> at org.apache.solr.update.UpdateLog.close(UpdateLog.java:848) [junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.closeWriter(DirectUpdateHandler2.java:789) [junit4] 2> at org.apache.solr.update.DefaultSolrCoreState.closeIndexWriter(DefaultSolrCoreState.java:70) [junit4] 2> at org.apache.solr.update.DefaultSolrCoreState.close(DefaultSolrCoreState.java:371) [junit4] 2> at org.apache.solr.update.SolrCoreState.decrefSolrCoreState(SolrCoreState.java:72) [junit4] 2> at org.apache.solr.core.SolrCore.close(SolrCore.java:1089) [junit4] 2> at org.apache.solr.core.SolrCores.close(SolrCores.java:117) [junit4] 2> at org.apache.solr.core.CoreContainer.shutdown(CoreContainer.java:347) [junit4] 2> at org.apache.solr.util.TestHarness.close(TestHarness.java:337) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.deleteCore(SolrTestCaseJ4.java:620) [junit4] 2> at org.apache.solr.SolrTestCaseJ4.afterClass(SolrTestCaseJ4.java:183) [junit4] 2> at sun.reflect.GeneratedMethodAccessor31.invoke(Unknown Source) [junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4] 2> at java.lang.reflect.Method.invoke(Method.java:483) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1618) [junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:790) [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:43) [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> Caused by: java.nio.channels.ClosedChannelException [junit4] 2> at sun.nio.ch.FileChannelImpl.ensureOpen(FileChannelImpl.java:109) [junit4] 2> at sun.nio.ch.FileChannelImpl.write(FileChannelImpl.java:198) [junit4] 2> at java.nio.channels.Channels.writeFullyImpl(Channels.java:78) [junit4] 2> at java.nio.channels.Channels.writeFully(Channels.java:101) [junit4] 2> at java.nio.channels.Channels.access$000(Channels.java:61) [junit4] 2> at java.nio.channels.Channels$1.write(Channels.java:174) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:214) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flushBuffer(FastOutputStream.java:207) [junit4] 2> at org.apache.solr.common.util.FastOutputStream.flush(FastOutputStream.java:191) [junit4] 2> at org.apache.solr.update.TransactionLog.close(TransactionLog.java:541) [junit4] 2> ... 36 more [junit4] 2> [junit4] 2> 442025 T1227 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4] 2> 442025 T1227 oasc.CachingDirectoryFactory.close Closing MockDirectoryFactory - 2 directories currently being tracked [junit4] 2> 442025 T1227 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index;done=false>>] [junit4] 2> 442025 T1227 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\index [junit4] 2> 442027 T1227 oasc.CachingDirectoryFactory.closeCacheValue looking to close C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\ [CachedDir<<refCount=0;path=C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\;done=false>>] [junit4] 2> 442027 T1227 oasc.CachingDirectoryFactory.close Closing directory: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\ [junit4] 2> NOTE: test params are: codec=Lucene49, sim=RandomSimilarityProvider(queryNorm=false,coord=crazy): {}, locale=sr_CS, timezone=Asia/Vladivostok [junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.8.0_20 (64-bit)/cpus=2,threads=1,free=103591024,total=221278208 [junit4] 2> NOTE: All tests run in this JVM: [DateFieldTest, TestIBSimilarityFactory, CachingDirectoryFactoryTest, CoreMergeIndexesAdminHandlerTest, AssignTest, DistanceFunctionTest, QueryResultKeyTest, CircularListTest, TestTolerantSearch, TestExceedMaxTermLength, HdfsLockFactoryTest, AnalyticsQueryTest, ShowFileRequestHandlerTest, TestSolr4Spatial, CSVRequestHandlerTest, LoggingHandlerTest, DistributedDebugComponentTest, OutOfBoxZkACLAndCredentialsProvidersTest, DisMaxRequestHandlerTest, IndexBasedSpellCheckerTest, TestSolrXmlPersistence, TermVectorComponentDistributedTest, TestFastLRUCache, PeerSyncTest, MultiThreadedOCPTest, TestFunctionQuery, TestExpandComponent, StressHdfsTest, SuggesterWFSTTest, DistribDocExpirationUpdateProcessorTest, DistributedSuggestComponentTest, CursorPagingTest, HardAutoCommitTest] [junit4] 2> NOTE: reproduce with: ant test -Dtestcase=HardAutoCommitTest -Dtests.seed=CFFBD97665B3FD4E -Dtests.slow=true -Dtests.locale=sr_CS -Dtests.timezone=Asia/Vladivostok -Dtests.file.encoding=ISO-8859-1 [junit4] ERROR 0.00s | HardAutoCommitTest (suite) <<< [junit4] > Throwable #1: java.io.IOException: Could not remove the following files (in the order of attempts): [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000000 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog\tlog.0000000000000000001 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001\tlog [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001\init-core-data-001 [junit4] > C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build\solr-core\test\J0\.\temp\solr.update.HardAutoCommitTest-CFFBD97665B3FD4E-001 [junit4] > at __randomizedtesting.SeedInfo.seed([CFFBD97665B3FD4E]:0) [junit4] > at org.apache.lucene.util.TestUtil.rm(TestUtil.java:117) [junit4] > at java.lang.Thread.run(Thread.java:745) [junit4] Completed in 4.87s, 1 test, 1 error <<< FAILURES! [...truncated 1232 lines...] BUILD FAILED C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:492: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:472: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\build.xml:60: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\extra-targets.xml:39: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\build.xml:189: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\solr\common-build.xml:494: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:1344: The following error occurred while executing this line: C:\Users\JenkinsSlave\workspace\Lucene-Solr-4.x-Windows\lucene\common-build.xml:959: There were test failures: 422 suites, 1748 tests, 1 suite-level error, 48 ignored (27 assumptions) Total time: 133 minutes 39 seconds Build step 'Invoke Ant' marked build as failure [description-setter] Description set: Java: 64bit/jdk1.8.0_20 -XX:+UseCompressedOops -XX:+UseConcMarkSweepGC 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