Return-Path: X-Original-To: apmail-lucene-dev-archive@www.apache.org Delivered-To: apmail-lucene-dev-archive@www.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 84978D590 for ; Thu, 13 Sep 2012 16:39:32 +0000 (UTC) Received: (qmail 65269 invoked by uid 500); 13 Sep 2012 16:39:31 -0000 Delivered-To: apmail-lucene-dev-archive@lucene.apache.org Received: (qmail 65212 invoked by uid 500); 13 Sep 2012 16:39:31 -0000 Mailing-List: contact dev-help@lucene.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: dev@lucene.apache.org Delivered-To: mailing list dev@lucene.apache.org Received: (qmail 65205 invoked by uid 99); 13 Sep 2012 16:39:31 -0000 Received: from athena.apache.org (HELO athena.apache.org) (140.211.11.136) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 13 Sep 2012 16:39:31 +0000 X-ASF-Spam-Status: No, hits=-0.0 required=5.0 tests=SPF_PASS X-Spam-Check-By: apache.org Received-SPF: pass (athena.apache.org: local policy) Received: from [188.138.97.18] (HELO mail.sd-datasolutions.de) (188.138.97.18) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 13 Sep 2012 16:39:22 +0000 Received: from serv1 (localhost.localdomain [127.0.0.1]) by mail.sd-datasolutions.de (Postfix) with ESMTP id 37C8E14AA06C; Thu, 13 Sep 2012 16:39:00 +0000 (UTC) Date: Thu, 13 Sep 2012 16:38:43 +0000 (UTC) From: Policeman Jenkins Server To: dev@lucene.apache.org, rmuir@apache.org, yonik@apache.org Message-ID: <1078905100.71.1347554340209.JavaMail.jenkins@serv1.sd-datasolutions.de> Subject: [JENKINS] Lucene-Solr-trunk-Windows (32bit/jdk1.7.0_07) - Build # 755 - Failure! MIME-Version: 1.0 Content-Type: multipart/mixed; boundary="----=_Part_70_1413825912.1347554323915" X-Virus-Checked: Checked by ClamAV on apache.org ------=_Part_70_1413825912.1347554323915 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Windows/755/ Java: 32bit/jdk1.7.0_07 -client -XX:+UseSerialGC 1 tests failed. REGRESSION: org.apache.solr.search.TestRecovery.testRemoveOldLogs Error Message: expected:<0> but was:<1> Stack Trace: java.lang.AssertionError: expected:<0> but was:<1> at __randomizedtesting.SeedInfo.seed([60190B42E904DE2B:4185CAE9213E57D3]:0) at org.junit.Assert.fail(Assert.java:93) at org.junit.Assert.failNotEquals(Assert.java:647) at org.junit.Assert.assertEquals(Assert.java:128) at org.junit.Assert.assertEquals(Assert.java:472) at org.junit.Assert.assertEquals(Assert.java:456) at org.apache.solr.search.TestRecovery.testRemoveOldLogs(TestRecovery.java:721) at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) at java.lang.reflect.Method.invoke(Method.java:601) at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737) at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773) at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782) at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442) at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746) at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648) at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682) at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) at java.lang.Thread.run(Thread.java:722) Build Log: [...truncated 7746 lines...] [junit4:junit4] Suite: org.apache.solr.search.TestRecovery [junit4:junit4] 2> 3 T334 oas.SolrTestCaseJ4.initCore ####initCore [junit4:junit4] 2> Creating dataDir: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846 [junit4:junit4] 2> 6 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 11 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 12 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 104 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 189 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 190 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 199 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 1206 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 1214 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 1229 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 1230 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 1230 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 1256 T334 oasc.CoreContainer. New CoreContainer 22059523 [junit4:junit4] 2> 1257 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 1257 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 1259 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 1261 T334 oasc.SolrCore.initIndex WARNING [collection1] Solr index directory 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index' doesn't exist. Creating new index... [junit4:junit4] 2> 1261 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 1269 T334 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@662740),segFN=segments_1,generation=1,filenames=[segments_1] [junit4:junit4] 2> 1270 T334 oasc.SolrDeletionPolicy.updateCommits newest commit = 1 [junit4:junit4] 2> 1272 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 1272 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 1273 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 1273 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 1280 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 1295 T334 oass.SolrIndexSearcher. Opening Searcher@144d799 main [junit4:junit4] 2> 1296 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 1299 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 1300 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 1300 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 1300 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 1301 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 1301 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 1302 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 1302 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 1302 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 1303 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 1303 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 1304 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 1319 T335 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@144d799 main{StandardDirectoryReader(segments_1:1)} [junit4:junit4] 2> 1319 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> 1321 T334 oas.SolrTestCaseJ4.initCore ####initCore end [junit4:junit4] 2> 1327 T334 oas.SolrTestCaseJ4.setUp ###Starting testLogReplay [junit4:junit4] 2> ASYNC NEW_CORE C46 name=collection1 org.apache.solr.core.SolrCore@b278ab [junit4:junit4] 2> 1340 T334 C46 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 1346 T334 C46 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@662740),segFN=segments_1,generation=1,filenames=[segments_1] [junit4:junit4] 2> 1347 T334 C46 oasc.SolrDeletionPolicy.updateCommits newest commit = 1 [junit4:junit4] 2> 1348 T334 C46 oass.SolrIndexSearcher. Opening Searcher@3c5bbd realtime [junit4:junit4] 2> 1349 T334 C46 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 1349 T334 C46 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=10 [junit4:junit4] 2> 1358 T334 C46 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 1362 T334 C46 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@662740),segFN=segments_1,generation=1,filenames=[segments_1] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@662740),segFN=segments_2,generation=2,filenames=[segments_2] [junit4:junit4] 2> 1363 T334 C46 oasc.SolrDeletionPolicy.updateCommits newest commit = 2 [junit4:junit4] 2> 1369 T334 C46 oass.SolrIndexSearcher. Opening Searcher@17767ee main [junit4:junit4] 2> 1369 T334 C46 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 1370 T335 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@17767ee main{StandardDirectoryReader(segments_1:2:nrt)} [junit4:junit4] 2> 1370 T334 C46 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 1371 T334 C46 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 13 [junit4:junit4] 2> 1418 T334 C46 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A1 (1413012018961580032)]} 0 4 [junit4:junit4] 2> 1427 T334 C46 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A11 (1413012018974162944)]} 0 1 [junit4:junit4] 2> 1434 T334 C46 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A12 (1413012018982551552)]} 0 0 [junit4:junit4] 2> 1499 T334 C46 oass.SolrIndexSearcher. Opening Searcher@1ef9572 realtime [junit4:junit4] 2> 1500 T334 C46 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 1500 T334 C46 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {deleteByQuery=id:A11 (-1413012018990940160)} 0 58 [junit4:junit4] 2> 1509 T334 C46 UPDATE [collection1] webapp=null path=null params={versions=true&wt=json&indent=true} {add=[A13 (1413012019060146176)]} 0 2 [junit4:junit4] 2> 1510 T334 C46 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=1 [junit4:junit4] 2> 1510 T334 C46 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 1512 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=22059523 [junit4:junit4] 2> 1512 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@b278ab [junit4:junit4] 2> 1513 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 1513 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=4,adds=4,deletesById=0,deletesByQuery=1,errors=1,cumulative_adds=4,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=1} [junit4:junit4] 2> 1513 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 1523 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 1523 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 1527 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 1529 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 1635 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 1741 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 1744 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 1752 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 2586 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 2591 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 2603 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 2604 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 2604 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 2618 T334 oasc.CoreContainer. New CoreContainer 25857288 [junit4:junit4] 2> 2618 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 2619 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 2620 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 2621 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 2622 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 2622 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 2623 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 2627 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 2632 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 2633 T334 oass.SolrIndexSearcher. Opening Searcher@14b6d51 main [junit4:junit4] 2> 2634 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 2637 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 2638 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 2638 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 2639 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 2639 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 2639 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 2641 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 2642 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 2642 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 2643 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 2643 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 2643 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 2660 T336 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@14b6d51 main{StandardDirectoryReader(segments_2:2)} [junit4:junit4] 2> 2660 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C47 name=collection1 org.apache.solr.core.SolrCore@156c280 [junit4:junit4] 2> 2668 T337 C47 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000001 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 2672 T334 C47 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=4 [junit4:junit4] 2> 2673 T334 C47 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 2674 T334 C47 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 2685 T337 C47 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f7283),segFN=segments_2,generation=2,filenames=[segments_2] [junit4:junit4] 2> 2685 T337 C47 oasc.SolrDeletionPolicy.updateCommits newest commit = 2 [junit4:junit4] 2> 2685 T337 C47 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=1413012018961580032,id=A1} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 2692 T337 C47 oass.SolrIndexSearcher. Opening Searcher@3cafba realtime [junit4:junit4] 2> 2692 T337 C47 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 2692 T337 C47 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=1413012018974162944,id=A11} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 2707 T337 C47 oass.SolrIndexSearcher. Opening Searcher@13e4be9 realtime [junit4:junit4] 2> 2707 T337 C47 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 2707 T337 C47 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=1413012018982551552,id=A12} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 2719 T337 C47 oass.SolrIndexSearcher. Opening Searcher@69bea3 realtime [junit4:junit4] 2> 2719 T337 C47 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 2731 T337 C47 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 2739 T337 C47 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f7283),segFN=segments_2,generation=2,filenames=[segments_2] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@2f7283),segFN=segments_3,generation=3,filenames=[_3.fld, _2.si, _2.pst, _3.inf, _2.fld, _2.inf, _3.si, _0.inf, _0.si, _0.pst, _0.fld, segments_3, _3.pst] [junit4:junit4] 2> 2739 T337 C47 oasc.SolrDeletionPolicy.updateCommits newest commit = 3 [junit4:junit4] 2> 2745 T337 C47 oass.SolrIndexSearcher. Opening Searcher@10d3766 main [junit4:junit4] 2> 2746 T337 C47 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 2746 T337 C47 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 2746 T336 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@10d3766 main{StandardDirectoryReader(segments_3:12:nrt _0(5.0):C1 _2(5.0):C1 _3(5.0):C1)} [junit4:junit4] 2> 2747 T337 C47 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=4 deletes=0 deleteByQuery=1 errors=0 positionOfStart=0} [junit4:junit4] 2> 2747 T334 C47 REQ [collection1] webapp=null path=null params={q=*:*} hits=3 status=0 QTime=0 [junit4:junit4] 2> 2749 T334 C47 REQ [collection1] webapp=null path=null params={getVersions=5&qt=/get} status=0 QTime=1 [junit4:junit4] 2> 2761 T334 C47 UPDATE [collection1] webapp=null path=null params={} {add=[A2 (1413012020370866176)]} 0 3 [junit4:junit4] 2> 2800 T334 C47 UPDATE [collection1] webapp=null path=null params={} {add=[A3 (1413012020412809216)]} 0 2 [junit4:junit4] 2> 2805 T334 C47 UPDATE [collection1] webapp=null path=null params={} {delete=[A2 (-1413012020420149248)]} 0 0 [junit4:junit4] 2> 2819 T334 C47 UPDATE [collection1] webapp=null path=null params={} {add=[A4 (1413012020434829312)]} 0 1 [junit4:junit4] 2> 2824 T334 C47 REQ [collection1] webapp=null path=null params={q=*:*} hits=3 status=0 QTime=0 [junit4:junit4] 2> 2825 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=25857288 [junit4:junit4] 2> 2826 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@156c280 [junit4:junit4] 2> 2829 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 2830 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=1,deletesByQuery=0,errors=0,cumulative_adds=7,cumulative_deletesById=1,cumulative_deletesByQuery=1,cumulative_errors=0} [junit4:junit4] 2> 2832 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 2850 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 2851 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 2853 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 2854 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 2924 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 3008 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 3008 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 3019 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 3836 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 3841 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 3859 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 3859 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 3859 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 3875 T334 oasc.CoreContainer. New CoreContainer 20828423 [junit4:junit4] 2> 3876 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 3876 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 3877 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 3880 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 3880 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 3881 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 3881 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 3884 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 3891 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 3897 T334 oass.SolrIndexSearcher. Opening Searcher@1dd6c64 main [junit4:junit4] 2> 3898 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 3909 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 3909 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 3910 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 3911 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 3911 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 3911 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 3912 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 3912 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 3913 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 3913 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 3913 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 3915 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 3931 T338 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1dd6c64 main{StandardDirectoryReader(segments_3:12 _0(5.0):C1 _2(5.0):C1 _3(5.0):C1)} [junit4:junit4] 2> 3931 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C48 name=collection1 org.apache.solr.core.SolrCore@2aa91a [junit4:junit4] 2> 3933 T339 C48 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000003 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 3946 T339 C48 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3beb19),segFN=segments_3,generation=3,filenames=[_3.fld, _2.pst, _2.si, _3.inf, _2.fld, _2.inf, _3.si, _0.inf, _0.si, _0.pst, _0.fld, segments_3, _3.pst] [junit4:junit4] 2> 3947 T339 C48 oasc.SolrDeletionPolicy.updateCommits newest commit = 3 [junit4:junit4] 2> 3949 T339 C48 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 3966 T339 C48 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3beb19),segFN=segments_3,generation=3,filenames=[_3.fld, _2.pst, _2.si, _3.inf, _2.fld, _2.inf, _3.si, _0.inf, _0.si, _0.pst, _0.fld, segments_3, _3.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3beb19),segFN=segments_4,generation=4,filenames=[_2.si, _3.fld, _2.fld, _4.fld, _2.inf, _4.si, _4.inf, _0.pst, _0.fld, _3.pst, _4.pst, _2.pst, _3.inf, _0.inf, _3.si, _0.si, segments_4] [junit4:junit4] 2> 3966 T339 C48 oasc.SolrDeletionPolicy.updateCommits newest commit = 4 [junit4:junit4] 2> 3983 T339 C48 oass.SolrIndexSearcher. Opening Searcher@1c43375 main [junit4:junit4] 2> 3984 T339 C48 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 3984 T339 C48 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 3985 T338 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1c43375 main{StandardDirectoryReader(segments_4:14 _0(5.0):C1 _2(5.0):C1 _3(5.0):C1 _4(5.0):C2)} [junit4:junit4] 2> 3987 T339 C48 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=3 deletes=1 deleteByQuery=0 errors=0 positionOfStart=0} [junit4:junit4] 2> 3988 T334 C48 REQ [collection1] webapp=null path=null params={q=*:*} hits=5 status=0 QTime=1 [junit4:junit4] 2> 3990 T334 C48 REQ [collection1] webapp=null path=null params={q=id:A2} hits=0 status=0 QTime=1 [junit4:junit4] 2> 3991 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=20828423 [junit4:junit4] 2> 3991 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2aa91a [junit4:junit4] 2> 3992 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 3992 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4:junit4] 2> 3994 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 4019 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 4020 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 4024 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 4026 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 4136 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 4225 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 4226 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 4231 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 5061 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 5075 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 5091 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 5091 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 5091 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 5112 T334 oasc.CoreContainer. New CoreContainer 17354005 [junit4:junit4] 2> 5113 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 5113 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 5117 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 5118 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 5119 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 5119 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 5120 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 5125 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 5131 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 5141 T334 oass.SolrIndexSearcher. Opening Searcher@1de47cf main [junit4:junit4] 2> 5141 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 5146 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 5147 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 5147 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 5147 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 5147 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 5148 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 5148 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 5149 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 5149 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 5150 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 5150 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 5151 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 5162 T340 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1de47cf main{StandardDirectoryReader(segments_4:14 _0(5.0):C1 _2(5.0):C1 _3(5.0):C1 _4(5.0):C2)} [junit4:junit4] 2> 5162 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C49 name=collection1 org.apache.solr.core.SolrCore@b828d5 [junit4:junit4] 2> 5163 T334 C49 REQ [collection1] webapp=null path=null params={q=*:*} hits=5 status=0 QTime=0 [junit4:junit4] 2> 5264 T334 oas.SolrTestCaseJ4.tearDown ###Ending testLogReplay [junit4:junit4] 2> 5269 T334 oas.SolrTestCaseJ4.setUp ###Starting testVersionsOnRestart [junit4:junit4] 2> 5279 T334 C49 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 5289 T334 C49 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0c691),segFN=segments_4,generation=4,filenames=[_2.si, _3.fld, _2.fld, _4.fld, _2.inf, _4.inf, _4.si, _0.pst, _0.fld, _3.pst, _4.pst, _2.pst, _3.inf, _0.inf, _3.si, _0.si, segments_4] [junit4:junit4] 2> 5290 T334 C49 oasc.SolrDeletionPolicy.updateCommits newest commit = 4 [junit4:junit4] 2> 5293 T334 C49 oass.SolrIndexSearcher. Opening Searcher@b94e61 realtime [junit4:junit4] 2> 5293 T334 C49 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 5293 T334 C49 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=15 [junit4:junit4] 2> 5297 T334 C49 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 5300 T334 C49 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0c691),segFN=segments_4,generation=4,filenames=[_2.si, _3.fld, _2.fld, _4.fld, _2.inf, _4.inf, _4.si, _0.pst, _0.fld, _3.pst, _4.pst, _2.pst, _3.inf, _0.inf, _3.si, _0.si, segments_4] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0c691),segFN=segments_5,generation=5,filenames=[segments_5] [junit4:junit4] 2> 5301 T334 C49 oasc.SolrDeletionPolicy.updateCommits newest commit = 5 [junit4:junit4] 2> 5313 T334 C49 oass.SolrIndexSearcher. Opening Searcher@1014a18 main [junit4:junit4] 2> 5313 T334 C49 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 5314 T340 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1014a18 main{StandardDirectoryReader(segments_4:15:nrt)} [junit4:junit4] 2> 5314 T334 C49 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 5318 T334 C49 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 21 [junit4:junit4] 2> 5354 T334 C49 UPDATE [collection1] webapp=null path=null params={} {add=[D1 (1413012023080386560)]} 0 12 [junit4:junit4] 2> 5362 T334 C49 UPDATE [collection1] webapp=null path=null params={} {add=[D2 (1413012023099260928)]} 0 2 [junit4:junit4] 2> 5368 T334 C49 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 5381 T334 C49 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0c691),segFN=segments_5,generation=5,filenames=[segments_5] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@f0c691),segFN=segments_6,generation=6,filenames=[_5.si, _5.inf, _5.pst, _5.fld, segments_6] [junit4:junit4] 2> 5381 T334 C49 oasc.SolrDeletionPolicy.updateCommits newest commit = 6 [junit4:junit4] 2> 5386 T334 C49 oass.SolrIndexSearcher. Opening Searcher@a88a21 main [junit4:junit4] 2> 5386 T334 C49 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 5387 T340 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@a88a21 main{StandardDirectoryReader(segments_6:17:nrt _5(5.0):C2)} [junit4:junit4] 2> 5387 T334 C49 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 5387 T334 C49 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 19 [junit4:junit4] 2> 5392 T334 C49 REQ [collection1] webapp=null path=null params={q=id:D1} hits=1 status=0 QTime=0 [junit4:junit4] 2> 5394 T334 C49 REQ [collection1] webapp=null path=null params={q=id:D2} hits=1 status=0 QTime=1 [junit4:junit4] 2> 5394 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=17354005 [junit4:junit4] 2> 5395 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@b828d5 [junit4:junit4] 2> 5395 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 5395 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=2,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1} [junit4:junit4] 2> 5396 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 5402 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 5403 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 5406 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 5407 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 5475 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 5545 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 5546 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 5555 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 6505 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 6512 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 6527 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 6527 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 6528 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 6546 T334 oasc.CoreContainer. New CoreContainer 15160065 [junit4:junit4] 2> 6547 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 6547 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 6549 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 6552 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 6553 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 6554 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 6554 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 6560 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 6566 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 6570 T334 oass.SolrIndexSearcher. Opening Searcher@c30c24 main [junit4:junit4] 2> 6570 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 6575 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 6576 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 6576 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 6577 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 6578 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 6578 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 6578 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 6579 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 6580 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 6580 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 6581 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 6581 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 6596 T341 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c30c24 main{StandardDirectoryReader(segments_6:17 _5(5.0):C2)} [junit4:junit4] 2> 6596 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C50 name=collection1 org.apache.solr.core.SolrCore@1e3a8e [junit4:junit4] 2> 6610 T334 C50 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@14b52a2),segFN=segments_6,generation=6,filenames=[_5.si, _5.inf, _5.pst, _5.fld, segments_6] [junit4:junit4] 2> 6610 T334 C50 oasc.SolrDeletionPolicy.updateCommits newest commit = 6 [junit4:junit4] 2> 6613 T334 C50 UPDATE [collection1] webapp=null path=null params={} {add=[D1 (1413012024403689472)]} 0 9 [junit4:junit4] 2> 6627 T334 C50 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 6652 T334 C50 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@14b52a2),segFN=segments_6,generation=6,filenames=[_5.si, _5.inf, _5.pst, _5.fld, segments_6] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@14b52a2),segFN=segments_7,generation=7,filenames=[_5.si, _5_1.liv, _6.pst, _5.inf, segments_7, _6.fld, _6.si, _6.inf, _5.pst, _5.fld] [junit4:junit4] 2> 6653 T334 C50 oasc.SolrDeletionPolicy.updateCommits newest commit = 7 [junit4:junit4] 2> 6665 T334 C50 oass.SolrIndexSearcher. Opening Searcher@395bb0 main [junit4:junit4] 2> 6666 T334 C50 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 6666 T341 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@395bb0 main{StandardDirectoryReader(segments_7:20 _5(5.0):C2/1 _6(5.0):C1)} [junit4:junit4] 2> 6666 T334 C50 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 6667 T334 C50 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 40 [junit4:junit4] 2> 6677 T334 C50 REQ [collection1] webapp=null path=null params={q=id:D1} hits=1 status=0 QTime=1 [junit4:junit4] 2> 6678 T334 C50 REQ [collection1] webapp=null path=null params={getVersions=2&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 6679 T334 oas.SolrTestCaseJ4.tearDown ###Ending testVersionsOnRestart [junit4:junit4] 2> 6685 T334 oas.SolrTestCaseJ4.setUp ###Starting testBufferingFlags [junit4:junit4] 2> 6699 T334 C50 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 6701 T334 C50 oass.SolrIndexSearcher. Opening Searcher@15582e5 realtime [junit4:junit4] 2> 6702 T334 C50 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 6703 T334 C50 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=4 [junit4:junit4] 2> 6710 T334 C50 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 6713 T334 C50 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@14b52a2),segFN=segments_7,generation=7,filenames=[_5.si, _5_1.liv, _6.pst, _5.inf, segments_7, _6.fld, _6.si, _6.inf, _5.pst, _5.fld] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@14b52a2),segFN=segments_8,generation=8,filenames=[segments_8] [junit4:junit4] 2> 6714 T334 C50 oasc.SolrDeletionPolicy.updateCommits newest commit = 8 [junit4:junit4] 2> 6723 T334 C50 oass.SolrIndexSearcher. Opening Searcher@9c9e65 main [junit4:junit4] 2> 6724 T334 C50 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 6725 T341 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@9c9e65 main{StandardDirectoryReader(segments_7:21:nrt)} [junit4:junit4] 2> 6724 T334 C50 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 6727 T334 C50 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 18 [junit4:junit4] 2> 6735 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 6749 T334 C50 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 6758 T334 C50 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 6766 T334 C50 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 6767 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=15160065 [junit4:junit4] 2> 6768 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1e3a8e [junit4:junit4] 2> 6769 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 6774 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1} [junit4:junit4] 2> 6774 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 6782 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 6783 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 6786 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 6789 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 6893 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 6985 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 6987 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 6995 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 7801 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 7805 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 7815 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 7816 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 7816 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 7829 T334 oasc.CoreContainer. New CoreContainer 4076617 [junit4:junit4] 2> 7829 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 7830 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 7831 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 7832 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 7833 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 7833 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 7833 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 7836 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 7840 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 7842 T334 oass.SolrIndexSearcher. Opening Searcher@1ce812 main [junit4:junit4] 2> 7842 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 7846 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 7846 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 7847 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 7847 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 7848 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 7848 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 7848 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 7848 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 7848 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 7849 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 7849 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 7849 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 7858 T342 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1ce812 main{StandardDirectoryReader(segments_8:21)} [junit4:junit4] 2> 7858 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C51 name=collection1 org.apache.solr.core.SolrCore@14aeb29 [junit4:junit4] 2> 7859 T343 C51 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000008 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 7865 T343 C51 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c48525),segFN=segments_8,generation=8,filenames=[segments_8] [junit4:junit4] 2> 7866 T343 C51 oasc.SolrDeletionPolicy.updateCommits newest commit = 8 [junit4:junit4] 2> 7866 T343 C51 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=101,id=Q1} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 7870 T343 C51 oass.SolrIndexSearcher. Opening Searcher@73138a realtime [junit4:junit4] 2> 7870 T343 C51 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 7871 T343 C51 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=102,id=Q2} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 7875 T343 C51 oass.SolrIndexSearcher. Opening Searcher@1b36cc5 realtime [junit4:junit4] 2> 7875 T343 C51 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 7876 T343 C51 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=103,id=Q3} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 7880 T343 C51 oass.SolrIndexSearcher. Opening Searcher@10d7e2b realtime [junit4:junit4] 2> 7881 T343 C51 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 7881 T343 C51 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 7893 T343 C51 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c48525),segFN=segments_8,generation=8,filenames=[segments_8] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@1c48525),segFN=segments_9,generation=9,filenames=[_7.inf, _7.si, _7.pst, _8.pst, _8.fld, segments_9, _8.si, _9.inf, _7.fld, _9.fld, _9.si, _8.inf, _9.pst] [junit4:junit4] 2> 7893 T343 C51 oasc.SolrDeletionPolicy.updateCommits newest commit = 9 [junit4:junit4] 2> 7897 T343 C51 oass.SolrIndexSearcher. Opening Searcher@1a13f7a main [junit4:junit4] 2> 7898 T343 C51 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 7898 T343 C51 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 7899 T342 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1a13f7a main{StandardDirectoryReader(segments_8:27:nrt _7(5.0):C1 _8(5.0):C1 _9(5.0):C1)} [junit4:junit4] 2> 7900 T343 C51 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=3 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0} [junit4:junit4] 2> 7900 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=4076617 [junit4:junit4] 2> 7901 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@14aeb29 [junit4:junit4] 2> 7901 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 7902 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4:junit4] 2> 7904 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 7926 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 7927 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 7929 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 7930 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 8004 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 8070 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 8070 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 8081 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 8719 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 8723 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 8732 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 8733 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 8733 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 8747 T334 oasc.CoreContainer. New CoreContainer 7778392 [junit4:junit4] 2> 8749 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 8749 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 8751 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 8752 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 8753 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 8753 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 8753 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 8757 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 8759 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 8765 T334 oass.SolrIndexSearcher. Opening Searcher@cd597f main [junit4:junit4] 2> 8765 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 8769 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 8769 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 8770 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 8770 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 8770 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 8771 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 8771 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 8771 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 8772 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 8772 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 8772 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 8773 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 8782 T344 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@cd597f main{StandardDirectoryReader(segments_9:27 _7(5.0):C1 _8(5.0):C1 _9(5.0):C1)} [junit4:junit4] 2> 8782 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C52 name=collection1 org.apache.solr.core.SolrCore@17acfe1 [junit4:junit4] 2> 8798 T334 C52 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@97a3ad),segFN=segments_9,generation=9,filenames=[_7.inf, _7.si, _7.pst, _8.pst, _8.fld, segments_9, _8.si, _9.inf, _7.fld, _9.fld, _9.pst, _8.inf, _9.si] [junit4:junit4] 2> 8799 T334 C52 oasc.SolrDeletionPolicy.updateCommits newest commit = 9 [junit4:junit4] 2> 8800 T334 C52 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=114,id=Q4} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 8808 T334 C52 oass.SolrIndexSearcher. Opening Searcher@a94fa realtime [junit4:junit4] 2> 8808 T334 C52 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 8808 T334 C52 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=18 [junit4:junit4] 2> 8813 T334 C52 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=115,id=Q5} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 8818 T334 C52 oass.SolrIndexSearcher. Opening Searcher@a465a3 realtime [junit4:junit4] 2> 8819 T334 C52 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 8819 T334 C52 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=6 [junit4:junit4] 2> 8828 T334 C52 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=116,id=Q6} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 8835 T334 C52 oass.SolrIndexSearcher. Opening Searcher@1aefe9c realtime [junit4:junit4] 2> 8836 T334 C52 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 8836 T334 C52 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=8 [junit4:junit4] 2> 8841 T334 C52 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 8846 T334 C52 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@97a3ad),segFN=segments_9,generation=9,filenames=[_7.inf, _7.si, _7.pst, _8.pst, _8.fld, segments_9, _8.si, _9.inf, _7.fld, _9.fld, _9.pst, _8.inf, _9.si] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.MMapDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@97a3ad),segFN=segments_a,generation=10,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _b.pst, _8.si, _a.inf, _9.inf, _7.fld, _c.si, _b.fld, _b.si, _9.si, _7.inf, segments_a, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _9.fld, _c.fld, _8.inf, _9.pst] [junit4:junit4] 2> 8846 T334 C52 oasc.SolrDeletionPolicy.updateCommits newest commit = 10 [junit4:junit4] 2> 8849 T334 C52 oass.SolrIndexSearcher. Opening Searcher@133af0 main [junit4:junit4] 2> 8850 T334 C52 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 8850 T344 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@133af0 main{StandardDirectoryReader(segments_9:33:nrt _7(5.0):C1 _8(5.0):C1 _9(5.0):C1 _a(5.0):C1 _b(5.0):C1 _c(5.0):C1)} [junit4:junit4] 2> 8850 T334 C52 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 8852 T334 C52 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 11 [junit4:junit4] 2> 8872 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=7778392 [junit4:junit4] 2> 8872 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@17acfe1 [junit4:junit4] 2> 8873 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 8873 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4:junit4] 2> 8873 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 8898 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 8898 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 8901 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 8902 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 8969 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 9033 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 9034 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 9040 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 9680 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 9686 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 9696 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 9696 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 9696 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 9710 T334 oasc.CoreContainer. New CoreContainer 18530653 [junit4:junit4] 2> 9710 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 9710 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 9712 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 9714 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 9714 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 9714 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 9715 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 9719 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 9724 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 9731 T334 oass.SolrIndexSearcher. Opening Searcher@151f412 main [junit4:junit4] 2> 9731 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 9736 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 9736 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 9737 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 9738 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 9738 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 9738 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 9739 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 9748 T345 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@151f412 main{StandardDirectoryReader(segments_a:33 _7(5.0):C1 _8(5.0):C1 _9(5.0):C1 _a(5.0):C1 _b(5.0):C1 _c(5.0):C1)} [junit4:junit4] 2> 9748 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> 9749 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> ASYNC NEW_CORE C53 name=collection1 org.apache.solr.core.SolrCore@197439e [junit4:junit4] 2> 9767 T334 C53 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@7686f8),segFN=segments_a,generation=10,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _b.pst, _8.si, _a.inf, _9.inf, _7.fld, _c.si, _b.si, _b.fld, _9.si, _7.inf, segments_a, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _9.fld, _c.fld, _8.inf, _9.pst] [junit4:junit4] 2> 9768 T334 C53 oasc.SolrDeletionPolicy.updateCommits newest commit = 10 [junit4:junit4] 2> 9768 T334 C53 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=117,id=Q7} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 9778 T334 C53 oass.SolrIndexSearcher. Opening Searcher@eae88f realtime [junit4:junit4] 2> 9779 T334 C53 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 9779 T334 C53 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=21 [junit4:junit4] 2> 9779 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=18530653 [junit4:junit4] 2> 9780 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@197439e [junit4:junit4] 2> 9780 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 9780 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=0,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=1,adds=1,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=1,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0} [junit4:junit4] 2> 9781 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 9805 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 9805 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 9807 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 9808 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 9869 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 9947 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 9948 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 9953 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 10697 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 10701 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 10709 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 10710 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 10711 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 10723 T334 oasc.CoreContainer. New CoreContainer 26103553 [junit4:junit4] 2> 10724 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 10724 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 10726 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 10727 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 10727 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 10728 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 10729 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 10731 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 10735 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 10742 T334 oass.SolrIndexSearcher. Opening Searcher@920dde main [junit4:junit4] 2> 10742 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10746 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 10747 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 10747 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 10747 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 10748 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 10748 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 10748 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 10749 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 10749 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 10749 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 10750 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 10750 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 10761 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@920dde main{StandardDirectoryReader(segments_a:33 _7(5.0):C1 _8(5.0):C1 _9(5.0):C1 _a(5.0):C1 _b(5.0):C1 _c(5.0):C1)} [junit4:junit4] 2> 10761 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C54 name=collection1 org.apache.solr.core.SolrCore@1b8d279 [junit4:junit4] 2> 10766 T347 C54 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000010 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 10776 T347 C54 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_a,generation=10,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _b.pst, _8.si, _a.inf, _9.inf, _7.fld, _c.si, _b.si, _b.fld, _9.si, _7.inf, segments_a, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _9.fld, _c.fld, _8.inf, _9.pst] [junit4:junit4] 2> 10777 T347 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 10 [junit4:junit4] 2> 10777 T347 C54 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=117,id=Q7} DBQs=[DBQ{version=1413012018990940160,q=id:A11}] [junit4:junit4] 2> 10787 T347 C54 oass.SolrIndexSearcher. Opening Searcher@119e011 realtime [junit4:junit4] 2> 10787 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10787 T347 C54 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 10791 T347 C54 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_a,generation=10,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _b.pst, _8.si, _a.inf, _9.inf, _7.fld, _c.si, _b.si, _b.fld, _9.si, _7.inf, segments_a, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _9.fld, _c.fld, _8.inf, _9.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_b,generation=11,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _d.pst, _b.pst, _8.si, _a.inf, _9.inf, _d.inf, _7.fld, _c.si, _b.si, _b.fld, _9.si, _7.inf, segments_b, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _d.si, _9.fld, _c.fld, _8.inf, _9.pst, _d.fld] [junit4:junit4] 2> 10791 T347 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 11 [junit4:junit4] 2> 10793 T347 C54 oass.SolrIndexSearcher. Opening Searcher@1dfe086 main [junit4:junit4] 2> 10793 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10794 T347 C54 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 10794 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1dfe086 main{StandardDirectoryReader(segments_a:35:nrt _7(5.0):C1 _8(5.0):C1 _9(5.0):C1 _a(5.0):C1 _b(5.0):C1 _c(5.0):C1 _d(5.0):C1)} [junit4:junit4] 2> 10795 T347 C54 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=1 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0} [junit4:junit4] 2> 10795 T334 oas.SolrTestCaseJ4.tearDown ###Ending testBufferingFlags [junit4:junit4] 2> 10798 T334 oas.SolrTestCaseJ4.setUp ###Starting testBuffering [junit4:junit4] 2> 10811 T334 C54 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 10817 T334 C54 oass.SolrIndexSearcher. Opening Searcher@1f60505 realtime [junit4:junit4] 2> 10817 T334 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10818 T334 C54 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=7 [junit4:junit4] 2> 10822 T334 C54 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 10825 T334 C54 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_b,generation=11,filenames=[_c.inf, _7.si, _a.pst, _c.pst, _d.pst, _b.pst, _8.si, _a.inf, _9.inf, _d.inf, _7.fld, _c.si, _b.si, _b.fld, _9.si, _7.inf, segments_b, _7.pst, _a.si, _8.pst, _8.fld, _b.inf, _a.fld, _d.si, _9.fld, _c.fld, _8.inf, _9.pst, _d.fld] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_c,generation=12,filenames=[segments_c] [junit4:junit4] 2> 10826 T334 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 12 [junit4:junit4] 2> 10840 T334 C54 oass.SolrIndexSearcher. Opening Searcher@13da2f0 main [junit4:junit4] 2> 10841 T334 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10841 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@13da2f0 main{StandardDirectoryReader(segments_b:36:nrt)} [junit4:junit4] 2> 10841 T334 C54 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 10852 T334 C54 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 30 [junit4:junit4] 2> 10866 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 10866 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 10876 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 [junit4:junit4] 2> 10881 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10886 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-1017&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10893 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10898 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10906 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-2010&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10907 T334 C54 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=1 [junit4:junit4] 2> 10913 T334 C54 oasup.DistributedUpdateProcessor.processCommit Ignoring commit while not ACTIVE - state: BUFFERING replay:0 [junit4:junit4] 2> 10913 T334 C54 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 0 [junit4:junit4] 2> 10915 T334 C54 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=1 [junit4:junit4] 2> 10915 T334 C54 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=0 [junit4:junit4] 2> 10915 T334 C54 REQ [collection1] webapp=null path=null params={id=B3&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 10916 T347 C54 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000013 refcount=2} active=true starting pos=0 [junit4:junit4] 2> 10926 T347 C54 oass.SolrIndexSearcher. Opening Searcher@ab8e20 realtime [junit4:junit4] 2> 10926 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10928 T347 C54 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 10934 T347 C54 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_c,generation=12,filenames=[segments_c] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_d,generation=13,filenames=[segments_d, _f.fld, _f.pst, _f.inf, _f.si] [junit4:junit4] 2> 10934 T347 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 13 [junit4:junit4] 2> 10938 T347 C54 oass.SolrIndexSearcher. Opening Searcher@ba648 main [junit4:junit4] 2> 10938 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 10939 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ba648 main{StandardDirectoryReader(segments_d:42:nrt _f(5.0):C2)} [junit4:junit4] 2> 10940 T347 C54 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 10940 T347 C54 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=4 deletes=1 deleteByQuery=1 errors=0 positionOfStart=0} [junit4:junit4] 2> 10941 T334 C54 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=1 [junit4:junit4] 2> 10942 T334 C54 REQ [collection1] webapp=null path=null params={q=*:*} hits=2 status=0 QTime=1 [junit4:junit4] 2> 10942 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 10942 T334 C54 REQ [collection1] webapp=null path=null params={id=B3&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 10959 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 10964 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10972 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-940&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10977 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10982 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10988 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10993 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-3000&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 10993 T334 C54 REQ [collection1] webapp=null path=null params={getVersions=13&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 10994 T347 C54 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000014 refcount=2} active=true starting pos=0 [junit4:junit4] 2> 11000 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 11003 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-950&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 11009 T334 C54 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&_version_=-2060&versions=true&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 11016 T347 C54 oass.SolrIndexSearcher. Opening Searcher@260fb6 realtime [junit4:junit4] 2> 11016 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11017 T347 C54 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=10,_version_=1070,id=B7} DBQs=[DBQ{version=3000,q=id:B2 OR id:B8}] [junit4:junit4] 2> 11021 T347 C54 oass.SolrIndexSearcher. Opening Searcher@280c42 realtime [junit4:junit4] 2> 11021 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11022 T347 C54 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 11026 T347 C54 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_d,generation=13,filenames=[segments_d, _f.fld, _f.pst, _f.inf, _f.si] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_e,generation=14,filenames=[segments_e, _g.si, _h.inf, _f.fld, _h.fld, _g.inf, _f.inf, _f.si, _f_1.liv, _h.si, _f.pst, _g_1.liv, _g.fld, _h.pst, _g.pst] [junit4:junit4] 2> 11026 T347 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 14 [junit4:junit4] 2> 11029 T347 C54 oass.SolrIndexSearcher. Opening Searcher@8b719f main [junit4:junit4] 2> 11029 T347 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11030 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@8b719f main{StandardDirectoryReader(segments_e:48:nrt _f(5.0):C2/1 _g(5.0):C4/2 _h(5.0):C1)} [junit4:junit4] 2> 11030 T347 C54 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 11030 T347 C54 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=6 deletes=3 deleteByQuery=1 errors=0 positionOfStart=0} [junit4:junit4] 2> 11030 T334 C54 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=id+asc&q=*:*} hits=4 status=0 QTime=0 [junit4:junit4] 2> 11031 T334 oas.SolrTestCaseJ4.tearDown ###Ending testBuffering [junit4:junit4] 2> 11034 T334 oas.SolrTestCaseJ4.setUp ###Starting testCorruptLog [junit4:junit4] 2> 11046 T334 C54 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 11049 T334 C54 oass.SolrIndexSearcher. Opening Searcher@10c10a4 realtime [junit4:junit4] 2> 11049 T334 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11050 T334 C54 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=4 [junit4:junit4] 2> 11054 T334 C54 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 11057 T334 C54 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_e,generation=14,filenames=[segments_e, _g.si, _h.inf, _f.fld, _h.fld, _g.inf, _f.inf, _f.si, _f_1.liv, _h.si, _f.pst, _g_1.liv, _g.fld, _h.pst, _g.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@bf31c),segFN=segments_f,generation=15,filenames=[segments_f] [junit4:junit4] 2> 11058 T334 C54 oasc.SolrDeletionPolicy.updateCommits newest commit = 15 [junit4:junit4] 2> 11066 T334 C54 oass.SolrIndexSearcher. Opening Searcher@1637e59 main [junit4:junit4] 2> 11067 T334 C54 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11067 T346 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1637e59 main{StandardDirectoryReader(segments_e:49:nrt)} [junit4:junit4] 2> 11067 T334 C54 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 11072 T334 C54 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 18 [junit4:junit4] 2> 11084 T334 C54 UPDATE [collection1] webapp=null path=null params={} {add=[G1 (1413012029098164224)]} 0 3 [junit4:junit4] 2> 11089 T334 C54 UPDATE [collection1] webapp=null path=null params={} {add=[G2 (1413012029106552832)]} 0 0 [junit4:junit4] 2> 11099 T334 C54 UPDATE [collection1] webapp=null path=null params={} {add=[G3 (1413012029115990016)]} 0 1 [junit4:junit4] 2> 11101 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=26103553 [junit4:junit4] 2> 11102 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b8d279 [junit4:junit4] 2> 11103 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 11103 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=5,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=2,cumulative_adds=13,cumulative_deletesById=2,cumulative_deletesByQuery=4,cumulative_errors=2} [junit4:junit4] 2> 11103 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 11109 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 11113 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 11115 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 11117 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 11179 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 11243 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 11243 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 11249 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 11863 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 11867 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 11877 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 11877 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 11877 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 11890 T334 oasc.CoreContainer. New CoreContainer 2230819 [junit4:junit4] 2> 11891 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 11892 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 11893 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 11894 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 11895 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 11896 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 11896 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 11899 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 11903 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 11903 T334 oass.SolrIndexSearcher. Opening Searcher@82112e main [junit4:junit4] 2> 11903 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11907 T334 oasc.SolrException.log Ignoring exception matching Failure to open existing log file [junit4:junit4] 2> 11908 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 11909 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 11909 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 11909 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 11909 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 11910 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 11910 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 11911 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 11911 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 11911 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 11912 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 11912 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 11922 T348 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@82112e main{StandardDirectoryReader(segments_f:49)} [junit4:junit4] 2> 11922 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C55 name=collection1 org.apache.solr.core.SolrCore@2dad75 [junit4:junit4] 2> 11926 T334 C55 REQ [collection1] webapp=null path=null params={q=*:*} hits=0 status=0 QTime=0 [junit4:junit4] 2> 11939 T334 C55 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3c934b; maxCacheMB=0.1669921875 maxMergeSizeMB=0.3896484375)),segFN=segments_f,generation=15,filenames=[segments_f] [junit4:junit4] 2> 11940 T334 C55 oasc.SolrDeletionPolicy.updateCommits newest commit = 15 [junit4:junit4] 2> 11940 T334 C55 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=104,id=G4} DBQs=[DBQ{version=1413012018990940160,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}] [junit4:junit4] 2> 11947 T334 C55 oass.SolrIndexSearcher. Opening Searcher@17c71c7 realtime [junit4:junit4] 2> 11948 T334 C55 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11949 T334 C55 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=15 [junit4:junit4] 2> 11963 T334 C55 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=105,id=G5} DBQs=[DBQ{version=1413012018990940160,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}] [junit4:junit4] 2> 11970 T334 C55 oass.SolrIndexSearcher. Opening Searcher@395e27 realtime [junit4:junit4] 2> 11971 T334 C55 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11971 T334 C55 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=8 [junit4:junit4] 2> 11982 T334 C55 oasu.DirectUpdateHandler2.addDoc Reordered DBQs detected. Update=add{flags=0,_version_=106,id=G6} DBQs=[DBQ{version=1413012018990940160,q=id:A11}, DBQ{version=3000,q=id:B2 OR id:B8}, DBQ{version=1017,q=id:B1 id:B11 id:B2 id:B3}] [junit4:junit4] 2> 11987 T334 C55 oass.SolrIndexSearcher. Opening Searcher@7536f2 realtime [junit4:junit4] 2> 11988 T334 C55 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 11989 T334 C55 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=7 [junit4:junit4] 2> 11989 T334 C55 REQ [collection1] webapp=null path=null params={getVersions=3&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 11989 T334 oas.SolrTestCaseJ4.tearDown ###Ending testCorruptLog [junit4:junit4] 2> 11993 T334 oas.SolrTestCaseJ4.setUp ###Starting testCleanShutdown [junit4:junit4] 2> 12005 T334 C55 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 12011 T334 C55 oass.SolrIndexSearcher. Opening Searcher@122005a realtime [junit4:junit4] 2> 12012 T334 C55 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 12017 T334 C55 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=12 [junit4:junit4] 2> 12023 T334 C55 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 12031 T334 C55 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3c934b; maxCacheMB=0.1669921875 maxMergeSizeMB=0.3896484375)),segFN=segments_f,generation=15,filenames=[segments_f] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3c934b; maxCacheMB=0.1669921875 maxMergeSizeMB=0.3896484375)),segFN=segments_g,generation=16,filenames=[segments_g] [junit4:junit4] 2> 12031 T334 C55 oasc.SolrDeletionPolicy.updateCommits newest commit = 16 [junit4:junit4] 2> 12034 T334 C55 oass.SolrIndexSearcher. Opening Searcher@1f169db main [junit4:junit4] 2> 12035 T334 C55 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 12035 T348 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1f169db main{StandardDirectoryReader(segments_f:56:nrt)} [junit4:junit4] 2> 12035 T334 C55 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 12036 T334 C55 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 13 [junit4:junit4] 2> 12053 T334 C55 UPDATE [collection1] webapp=null path=null params={} {add=[E1 (1413012030115282944)]} 0 2 [junit4:junit4] 2> 12061 T334 C55 UPDATE [collection1] webapp=null path=null params={} {add=[E2 (1413012030125768704)]} 0 1 [junit4:junit4] 2> 12062 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2230819 [junit4:junit4] 2> 12063 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@2dad75 [junit4:junit4] 2> 12064 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 12064 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=2,adds=2,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1} [junit4:junit4] 2> 12064 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 12079 T334 C55 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3c934b; maxCacheMB=0.1669921875 maxMergeSizeMB=0.3896484375)),segFN=segments_g,generation=16,filenames=[segments_g] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@3c934b; maxCacheMB=0.1669921875 maxMergeSizeMB=0.3896484375)),segFN=segments_h,generation=17,filenames=[_l.si, _l.fld, _l.pst, _l.inf, segments_h] [junit4:junit4] 2> 12080 T334 C55 oasc.SolrDeletionPolicy.updateCommits newest commit = 17 [junit4:junit4] 2> 12089 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 12090 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 12092 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 12093 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 12160 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 12218 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 12219 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 12224 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 12845 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 12849 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 12863 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 12863 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 12863 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 12876 T334 oasc.CoreContainer. New CoreContainer 8966034 [junit4:junit4] 2> 12877 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 12877 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 12878 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 12880 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 12880 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 12881 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 12881 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 12884 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 12888 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 12891 T334 oass.SolrIndexSearcher. Opening Searcher@c012aa main [junit4:junit4] 2> 12892 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 12898 T334 oasc.SolrException.log SEVERE Failure to open existing log file (non fatal) C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000016:java.lang.RuntimeException: Invalid version (expected 2, but 0) or the data in not in 'javabin' format [junit4:junit4] 2> at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:109) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.readHeader(TransactionLog.java:253) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.(TransactionLog.java:159) [junit4:junit4] 2> at org.apache.solr.update.UpdateLog.init(UpdateLog.java:200) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.initLog(UpdateHandler.java:94) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.(UpdateHandler.java:123) [junit4:junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.(DirectUpdateHandler2.java:97) [junit4:junit4] 2> at sun.reflect.GeneratedConstructorAccessor121.newInstance(Unknown Source) [junit4:junit4] 2> at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [junit4:junit4] 2> at java.lang.reflect.Constructor.newInstance(Constructor.java:525) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:476) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:544) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:707) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:567) [junit4:junit4] 2> at org.apache.solr.util.TestHarness$Initializer.initialize(TestHarness.java:190) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:114) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:109) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:99) [junit4:junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:362) [junit4:junit4] 2> at org.apache.solr.search.TestRecovery.testCleanShutdown(TestRecovery.java:659) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4:junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4:junit4] 2> at java.lang.reflect.Method.invoke(Method.java:601) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] 2> at java.lang.Thread.run(Thread.java:722) [junit4:junit4] 2> [junit4:junit4] 2> 12903 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 12903 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 12904 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 12905 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 12905 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 12905 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 12905 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 12906 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 12906 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 12906 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 12907 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 12907 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 12916 T349 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@c012aa main{StandardDirectoryReader(segments_h:58 _l(5.0):C2)} [junit4:junit4] 2> 12916 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C56 name=collection1 org.apache.solr.core.SolrCore@1752758 [junit4:junit4] 2> 12922 T334 C56 REQ [collection1] webapp=null path=null params={q=*:*} hits=2 status=0 QTime=0 [junit4:junit4] 2> 12923 T334 oas.SolrTestCaseJ4.tearDown ###Ending testCleanShutdown [junit4:junit4] 2> 12928 T334 oas.SolrTestCaseJ4.setUp ###Starting testRecoveryMultipleLogs [junit4:junit4] 2> 12942 T334 C56 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 12952 T334 C56 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@96b4e7),segFN=segments_h,generation=17,filenames=[_l.si, _l.pst, _l.fld, _l.inf, segments_h] [junit4:junit4] 2> 12952 T334 C56 oasc.SolrDeletionPolicy.updateCommits newest commit = 17 [junit4:junit4] 2> 12952 T334 C56 oass.SolrIndexSearcher. Opening Searcher@15b32ea realtime [junit4:junit4] 2> 12952 T334 C56 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 12953 T334 C56 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=11 [junit4:junit4] 2> 12958 T334 C56 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 12960 T334 C56 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@96b4e7),segFN=segments_h,generation=17,filenames=[_l.si, _l.pst, _l.fld, _l.inf, segments_h] [junit4:junit4] 2> commit{dir=MockDirWrapper(org.apache.lucene.store.SimpleFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@96b4e7),segFN=segments_i,generation=18,filenames=[segments_i] [junit4:junit4] 2> 12960 T334 C56 oasc.SolrDeletionPolicy.updateCommits newest commit = 18 [junit4:junit4] 2> 12964 T334 C56 oass.SolrIndexSearcher. Opening Searcher@1859334 main [junit4:junit4] 2> 12964 T334 C56 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 12965 T334 C56 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 12966 T349 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1859334 main{StandardDirectoryReader(segments_h:59:nrt)} [junit4:junit4] 2> 12967 T334 C56 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 9 [junit4:junit4] 2> 12986 T334 C56 UPDATE [collection1] webapp=null path=null params={} {add=[AAAAAA (1413012031093604352)]} 0 2 [junit4:junit4] 2> 12993 T334 C56 UPDATE [collection1] webapp=null path=null params={} {add=[BBBBBB (1413012031101992960)]} 0 1 [junit4:junit4] 2> 13003 T334 C56 UPDATE [collection1] webapp=null path=null params={} {add=[CCCCCC (1413012031113527296)]} 0 0 [junit4:junit4] 2> 13006 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=8966034 [junit4:junit4] 2> 13006 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1752758 [junit4:junit4] 2> 13008 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 13010 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=1,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=3,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1} [junit4:junit4] 2> 13010 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 13015 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 13019 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 13020 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 13021 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 13088 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 13150 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 13151 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 13156 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 13775 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 13780 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 13790 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 13790 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 13790 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 13807 T334 oasc.CoreContainer. New CoreContainer 17632387 [junit4:junit4] 2> 13807 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 13807 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 13808 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 13811 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 13811 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 13812 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 13812 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 13814 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 13819 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 13820 T334 oass.SolrIndexSearcher. Opening Searcher@161373c main [junit4:junit4] 2> 13820 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 13823 T334 oasc.SolrException.log SEVERE Failure to open existing log file (non fatal) C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000016:java.lang.RuntimeException: Invalid version (expected 2, but 0) or the data in not in 'javabin' format [junit4:junit4] 2> at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:109) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.readHeader(TransactionLog.java:253) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.(TransactionLog.java:159) [junit4:junit4] 2> at org.apache.solr.update.UpdateLog.init(UpdateLog.java:200) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.initLog(UpdateHandler.java:94) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.(UpdateHandler.java:123) [junit4:junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.(DirectUpdateHandler2.java:97) [junit4:junit4] 2> at sun.reflect.GeneratedConstructorAccessor121.newInstance(Unknown Source) [junit4:junit4] 2> at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [junit4:junit4] 2> at java.lang.reflect.Constructor.newInstance(Constructor.java:525) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:476) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:544) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:707) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:567) [junit4:junit4] 2> at org.apache.solr.util.TestHarness$Initializer.initialize(TestHarness.java:190) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:114) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:109) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:99) [junit4:junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:362) [junit4:junit4] 2> at org.apache.solr.search.TestRecovery.testRecoveryMultipleLogs(TestRecovery.java:1013) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4:junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4:junit4] 2> at java.lang.reflect.Method.invoke(Method.java:601) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] 2> at java.lang.Thread.run(Thread.java:722) [junit4:junit4] 2> [junit4:junit4] 2> 13826 T334 oasu.CommitTracker. Hard AutoCommit: disabled [junit4:junit4] 2> 13827 T334 oasu.CommitTracker. Soft AutoCommit: disabled [junit4:junit4] 2> 13827 T334 oashc.HttpShardHandlerFactory.getParameter Setting socketTimeout to: 0 [junit4:junit4] 2> 13827 T334 oashc.HttpShardHandlerFactory.getParameter Setting urlScheme to: http:// [junit4:junit4] 2> 13828 T334 oashc.HttpShardHandlerFactory.getParameter Setting connTimeout to: 0 [junit4:junit4] 2> 13828 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxConnectionsPerHost to: 20 [junit4:junit4] 2> 13828 T334 oashc.HttpShardHandlerFactory.getParameter Setting corePoolSize to: 0 [junit4:junit4] 2> 13829 T334 oashc.HttpShardHandlerFactory.getParameter Setting maximumPoolSize to: 2147483647 [junit4:junit4] 2> 13829 T334 oashc.HttpShardHandlerFactory.getParameter Setting maxThreadIdleTime to: 5 [junit4:junit4] 2> 13829 T334 oashc.HttpShardHandlerFactory.getParameter Setting sizeOfQueue to: -1 [junit4:junit4] 2> 13830 T334 oashc.HttpShardHandlerFactory.getParameter Setting fairnessPolicy to: false [junit4:junit4] 2> 13830 T334 oascsi.HttpClientUtil.createClient Creating new http client, config:maxConnectionsPerHost=20&maxConnections=10000&socketTimeout=0&connTimeout=0&retry=false [junit4:junit4] 2> 13839 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@161373c main{StandardDirectoryReader(segments_i:59)} [junit4:junit4] 2> 13839 T334 oasc.CoreContainer.register registering core: collection1 [junit4:junit4] 2> ASYNC NEW_CORE C57 name=collection1 org.apache.solr.core.SolrCore@1b8c21a [junit4:junit4] 2> 13840 T351 C57 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000020 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 13849 T351 C57 oasc.SolrDeletionPolicy.onInit SolrDeletionPolicy.onInit: commits:num=1 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_i,generation=18,filenames=[segments_i] [junit4:junit4] 2> 13850 T351 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 18 [junit4:junit4] 2> 13851 T351 C57 oasc.SolrException.log Ignoring exception matching OutOfBoundsException [junit4:junit4] 2> 13851 T351 C57 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 13862 T351 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_i,generation=18,filenames=[segments_i] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_j,generation=19,filenames=[_m.si, _m.inf, _m.pst, _m.fld, segments_j] [junit4:junit4] 2> 13863 T351 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 19 [junit4:junit4] 2> 13868 T351 C57 oass.SolrIndexSearcher. Opening Searcher@931da1 main [junit4:junit4] 2> 13868 T351 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 13869 T351 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 13869 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@931da1 main{StandardDirectoryReader(segments_j:61 _m(5.0):C3)} [junit4:junit4] 2> 13869 T351 C57 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000021 refcount=2} active=false starting pos=0 [junit4:junit4] 2> 13871 T351 C57 oasc.SolrException.log Ignoring exception matching OutOfBoundsException [junit4:junit4] 2> 13871 T351 C57 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 13884 T351 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_j,generation=19,filenames=[_m.si, _m.inf, _m.pst, _m.fld, segments_j] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_k,generation=20,filenames=[_n.inf, _m.si, _m.inf, _n.si, _n.pst, _m.pst, _m.fld, segments_k, _n.fld] [junit4:junit4] 2> 13884 T351 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 20 [junit4:junit4] 2> 13892 T351 C57 oass.SolrIndexSearcher. Opening Searcher@1db253f main [junit4:junit4] 2> 13892 T351 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 13892 T351 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 13893 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1db253f main{StandardDirectoryReader(segments_k:63 _m(5.0):C3 _n(5.0):C3)} [junit4:junit4] 2> 13893 T351 C57 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=6 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0} [junit4:junit4] 2> 13894 T334 C57 REQ [collection1] webapp=null path=null params={q=*:*} hits=6 status=0 QTime=1 [junit4:junit4] 2> 13895 T334 oas.SolrTestCaseJ4.tearDown ###Ending testRecoveryMultipleLogs [junit4:junit4] 2> 13898 T334 oas.SolrTestCaseJ4.setUp ###Starting testDropBuffered [junit4:junit4] 2> 13912 T334 C57 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 13913 T334 C57 oass.SolrIndexSearcher. Opening Searcher@e0fab9 realtime [junit4:junit4] 2> 13914 T334 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 13914 T334 C57 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=2 [junit4:junit4] 2> 13919 T334 C57 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 13925 T334 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_k,generation=20,filenames=[_n.inf, _m.si, _m.inf, _n.si, _n.pst, _m.pst, _m.fld, segments_k, _n.fld] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_l,generation=21,filenames=[segments_l] [junit4:junit4] 2> 13926 T334 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 21 [junit4:junit4] 2> 13933 T334 C57 oass.SolrIndexSearcher. Opening Searcher@ed18bb main [junit4:junit4] 2> 13934 T334 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 13934 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@ed18bb main{StandardDirectoryReader(segments_k:64:nrt)} [junit4:junit4] 2> 13934 T334 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 13935 T334 C57 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 16 [junit4:junit4] 2> 13949 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 13949 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 13959 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 [junit4:junit4] 2> 13970 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 13974 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 13974 T334 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000025 refcount=1}} [junit4:junit4] 2> 13975 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000025 refcount=1}} [junit4:junit4] 2> 13980 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 13985 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 13986 T351 C57 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000025 refcount=2} active=true starting pos=0 [junit4:junit4] 2> 13989 T351 C57 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 14009 T351 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_l,generation=21,filenames=[segments_l] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_m,generation=22,filenames=[segments_m, _o.si, _o.inf, _o.fld, _o.pst] [junit4:junit4] 2> 14009 T351 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 22 [junit4:junit4] 2> 14012 T351 C57 oass.SolrIndexSearcher. Opening Searcher@1761d26 main [junit4:junit4] 2> 14013 T351 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 14013 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1761d26 main{StandardDirectoryReader(segments_m:66:nrt _o(5.0):C2)} [junit4:junit4] 2> 14019 T351 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 14019 T351 C57 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=2 deletes=0 deleteByQuery=0 errors=0 positionOfStart=0} [junit4:junit4] 2> 14020 T334 C57 REQ [collection1] webapp=null path=null params={getVersions=2&qt=/get} status=0 QTime=1 [junit4:junit4] 2> 14034 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=3 [junit4:junit4] 2> 14046 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 14046 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000026 refcount=1}} [junit4:junit4] 2> 14052 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 14057 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 14057 T334 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000026 refcount=1}} [junit4:junit4] 2> 14058 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000026 refcount=1}} [junit4:junit4] 2> 14062 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 14068 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 14068 T351 C57 oasu.UpdateLog$LogReplayer.doReplay WARNING Starting log replay tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000026 refcount=2} active=true starting pos=92 [junit4:junit4] 2> 14071 T351 C57 oasu.DirectUpdateHandler2.commit start commit{flags=2,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 14087 T351 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_m,generation=22,filenames=[segments_m, _o.si, _o.inf, _o.fld, _o.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_n,generation=23,filenames=[_p.fld, _p.pst, _p.inf, segments_n, _o.si, _o.inf, _p.si, _o.fld, _o.pst] [junit4:junit4] 2> 14087 T351 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 23 [junit4:junit4] 2> 14090 T351 C57 oass.SolrIndexSearcher. Opening Searcher@19184a6 main [junit4:junit4] 2> 14090 T351 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 14091 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@19184a6 main{StandardDirectoryReader(segments_n:68:nrt _o(5.0):C2 _p(5.0):C4)} [junit4:junit4] 2> 14092 T351 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 14092 T351 C57 oasu.UpdateLog$LogReplayer.run WARNING Log replay finished. recoveryInfo=RecoveryInfo{adds=2 deletes=0 deleteByQuery=0 errors=0 positionOfStart=92} [junit4:junit4] 2> 14093 T334 C57 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=_version_+asc&q=*:*} hits=6 status=0 QTime=1 [junit4:junit4] 2> 14094 T334 C57 REQ [collection1] webapp=null path=null params={getVersions=6&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 14095 T334 oasu.UpdateLog.bufferUpdates Starting to buffer updates. FSUpdateLog{state=ACTIVE, tlog=null} [junit4:junit4] 2> 14108 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 14114 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=0 [junit4:junit4] 2> 14114 T334 oasu.UpdateLog.dropBufferedUpdates Dropping buffered updates FSUpdateLog{state=BUFFERING, tlog=tlog{file=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000027 refcount=1}} [junit4:junit4] 2> 14120 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=2 [junit4:junit4] 2> 14136 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=1 [junit4:junit4] 2> 14140 T334 C57 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 14158 T334 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_n,generation=23,filenames=[_p.fld, _p.pst, _p.inf, segments_n, _o.si, _o.inf, _p.si, _o.fld, _o.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_o,generation=24,filenames=[_q.si, _p.fld, _q.inf, _p.pst, _p.inf, segments_o, _q.fld, _o.si, _o.inf, _p.si, _o.fld, _o.pst, _q.pst] [junit4:junit4] 2> 14158 T334 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 24 [junit4:junit4] 2> 14163 T334 C57 oass.SolrIndexSearcher. Opening Searcher@31d3aa main [junit4:junit4] 2> 14163 T334 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 14164 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@31d3aa main{StandardDirectoryReader(segments_o:70:nrt _o(5.0):C2 _p(5.0):C4 _q(5.0):C2)} [junit4:junit4] 2> 14165 T334 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 14165 T334 C57 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 25 [junit4:junit4] 2> 14171 T334 C57 REQ [collection1] webapp=null path=null params={getVersions=2&qt=/get} status=0 QTime=0 [junit4:junit4] 2> 14172 T334 C57 REQ [collection1] webapp=null path=null params={fl=id,_version_&sort=_version_+desc&q=*:*&rows=2} hits=8 status=0 QTime=0 [junit4:junit4] 2> 14182 T334 C57 REQ [collection1] webapp=null path=null params={update.distrib=FROMLEADER&wt=json&indent=true} status=0 QTime=3 [junit4:junit4] 2> 14182 T334 oas.SolrTestCaseJ4.tearDown ###Ending testDropBuffered [junit4:junit4] 2> 14187 T334 oas.SolrTestCaseJ4.setUp ###Starting testTruncatedLog [junit4:junit4] 2> 14203 T334 C57 oasu.DirectUpdateHandler2.deleteAll [collection1] REMOVING ALL DOCUMENTS FROM INDEX [junit4:junit4] 2> 14206 T334 C57 oass.SolrIndexSearcher. Opening Searcher@dc8ec7 realtime [junit4:junit4] 2> 14207 T334 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 14207 T334 C57 REQ [collection1] webapp=null path=null params={_version_=-9223372036854775807&update.distrib=FROMLEADER&versions=true&wt=json&indent=true} status=0 QTime=4 [junit4:junit4] 2> 14212 T334 C57 oasu.DirectUpdateHandler2.commit start commit{flags=0,_version_=0,optimize=false,openSearcher=true,waitSearcher=true,expungeDeletes=false,softCommit=false} [junit4:junit4] 2> 14219 T334 C57 oasc.SolrDeletionPolicy.onCommit SolrDeletionPolicy.onCommit: commits:num=2 [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_o,generation=24,filenames=[_q.si, _p.fld, _q.inf, _p.pst, _p.inf, segments_o, _q.fld, _o.si, _o.inf, _p.si, _o.fld, _o.pst, _q.pst] [junit4:junit4] 2> commit{dir=MockDirWrapper(NRTCachingDirectory(org.apache.lucene.store.NIOFSDirectory@C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\solrtest-TestRecovery-1347553269846\index lockFactory=org.apache.lucene.store.NativeFSLockFactory@17292af; maxCacheMB=0.3916015625 maxMergeSizeMB=0.3154296875)),segFN=segments_p,generation=25,filenames=[segments_p] [junit4:junit4] 2> 14219 T334 C57 oasc.SolrDeletionPolicy.updateCommits newest commit = 25 [junit4:junit4] 2> 14228 T334 C57 oass.SolrIndexSearcher. Opening Searcher@1536f64 main [junit4:junit4] 2> 14228 T334 C57 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 14229 T350 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@1536f64 main{StandardDirectoryReader(segments_o:72:nrt)} [junit4:junit4] 2> 14230 T334 C57 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 14234 T334 C57 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 22 [junit4:junit4] 2> 14246 T334 C57 UPDATE [collection1] webapp=null path=null params={} {add=[F1 (1413012032413761536)]} 0 3 [junit4:junit4] 2> 14256 T334 C57 UPDATE [collection1] webapp=null path=null params={} {add=[F2 (1413012032426344448)]} 0 1 [junit4:junit4] 2> 14262 T334 C57 UPDATE [collection1] webapp=null path=null params={} {add=[F3 (1413012032433684480)]} 0 0 [junit4:junit4] 2> 14264 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=17632387 [junit4:junit4] 2> 14264 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1b8c21a [junit4:junit4] 2> 14265 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 14265 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=7,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=3,adds=3,deletesById=0,deletesByQuery=0,errors=2,cumulative_adds=18,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=2} [junit4:junit4] 2> 14265 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 14277 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 14282 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\' [junit4:junit4] 2> 14286 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/classes/' to classloader [junit4:junit4] 2> 14288 T334 oasc.SolrResourceLoader.replaceClassLoader Adding 'file:/C:/Jenkins/workspace/Lucene-Solr-trunk-Windows/solr/build/solr-core/test-files/solr/collection1/lib/README' to classloader [junit4:junit4] 2> 14370 T334 oasc.SolrConfig. Using Lucene MatchVersion: LUCENE_50 [junit4:junit4] 2> 14431 T334 oasc.SolrConfig. Loaded SolrConfig: solrconfig-tlog.xml [junit4:junit4] 2> 14432 T334 oass.IndexSchema.readSchema Reading Solr Schema [junit4:junit4] 2> 14437 T334 oass.IndexSchema.readSchema Schema name=test [junit4:junit4] 2> 15069 T334 oass.IndexSchema.readSchema default search field in schema is text [junit4:junit4] 2> 15073 T334 oass.IndexSchema.readSchema unique key field: id [junit4:junit4] 2> 15082 T334 oasc.SolrResourceLoader.locateSolrHome JNDI not configured for solr (NoInitialContextEx) [junit4:junit4] 2> 15083 T334 oasc.SolrResourceLoader.locateSolrHome using system property solr.solr.home: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr [junit4:junit4] 2> 15083 T334 oasc.SolrResourceLoader. new SolrResourceLoader for directory: 'C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\' [junit4:junit4] 2> 15094 T334 oasc.CoreContainer. New CoreContainer 21538967 [junit4:junit4] 2> 15095 T334 oasc.SolrCore. [collection1] Opening new SolrCore at C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test-files\solr\collection1\, dataDir=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\ [junit4:junit4] 2> 15095 T334 oasc.SolrCore. JMX monitoring not detected for core: collection1 [junit4:junit4] 2> 15097 T334 oasc.SolrCore.getNewIndexDir WARNING New index directory detected: old=null new=C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index/ [junit4:junit4] 2> 15098 T334 oasc.RequestHandlers.initHandlersFromConfig created standard: solr.StandardRequestHandler [junit4:junit4] 2> 15098 T334 oasc.RequestHandlers.initHandlersFromConfig created /get: solr.RealTimeGetHandler [junit4:junit4] 2> 15099 T334 oasc.RequestHandlers.initHandlersFromConfig created /update: solr.UpdateRequestHandler [junit4:junit4] 2> 15099 T334 oasc.RequestHandlers.initHandlersFromConfig created /admin/: org.apache.solr.handler.admin.AdminHandlers [junit4:junit4] 2> 15101 T334 oashl.XMLLoader.init xsltCacheLifetimeSeconds=60 [junit4:junit4] 2> 15105 T334 oasc.CachingDirectoryFactory.get return new directory for C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\index forceNew:false [junit4:junit4] 2> 15106 T334 oass.SolrIndexSearcher. Opening Searcher@11682d1 main [junit4:junit4] 2> 15106 T334 oass.SolrIndexSearcher.getIndexDir WARNING WARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 15109 T334 oasc.SolrException.log SEVERE Failure to open existing log file (non fatal) C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000016:java.lang.RuntimeException: Invalid version (expected 2, but 0) or the data in not in 'javabin' format [junit4:junit4] 2> at org.apache.solr.common.util.JavaBinCodec.unmarshal(JavaBinCodec.java:109) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.readHeader(TransactionLog.java:253) [junit4:junit4] 2> at org.apache.solr.update.TransactionLog.(TransactionLog.java:159) [junit4:junit4] 2> at org.apache.solr.update.UpdateLog.init(UpdateLog.java:200) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.initLog(UpdateHandler.java:94) [junit4:junit4] 2> at org.apache.solr.update.UpdateHandler.(UpdateHandler.java:123) [junit4:junit4] 2> at org.apache.solr.update.DirectUpdateHandler2.(DirectUpdateHandler2.java:97) [junit4:junit4] 2> at sun.reflect.GeneratedConstructorAccessor121.newInstance(Unknown Source) [junit4:junit4] 2> at sun.reflect.DelegatingConstructorAccessorImpl.newInstance(DelegatingConstructorAccessorImpl.java:45) [junit4:junit4] 2> at java.lang.reflect.Constructor.newInstance(Constructor.java:525) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createInstance(SolrCore.java:476) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.createUpdateHandler(SolrCore.java:544) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:707) [junit4:junit4] 2> at org.apache.solr.core.SolrCore.(SolrCore.java:567) [junit4:junit4] 2> at org.apache.solr.util.TestHarness$Initializer.initialize(TestHarness.java:190) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:114) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:109) [junit4:junit4] 2> at org.apache.solr.util.TestHarness.(TestHarness.java:99) [junit4:junit4] 2> at org.apache.solr.SolrTestCaseJ4.createCore(SolrTestCaseJ4.java:362) [junit4:junit4] 2> at org.apache.solr.search.TestRecovery.testTruncatedLog(TestRecovery.java:843) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4:junit4] 2> at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4:junit4] 2> at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4:junit4] 2> at java.lang.reflect.Method.invoke(Method.java:601) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] 2> at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] 2> at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4:junit4] 2> at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] 2> at com.carrotsearch.randomizedtesti [...truncated too long message...] ARNING: Directory impl does not support setting indexDir: org.apache.lucene.store.MockDirectoryWrapper [junit4:junit4] 2> 15242 T352 oasc.SolrCore.registerSearcher [collection1] Registered new searcher Searcher@370bd0 main{StandardDirectoryReader(segments_q:81:nrt)} [junit4:junit4] 2> 15244 T334 C58 oasu.DirectUpdateHandler2.commit end_commit_flush [junit4:junit4] 2> 15244 T334 C58 UPDATE [collection1] webapp=null path=null params={} {commit=} 0 12 [junit4:junit4] 2> 15262 T334 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=21538967 [junit4:junit4] 2> 15262 T334 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1701e4c [junit4:junit4] 2> 15263 T334 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request. [junit4:junit4] 2> 15265 T334 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=2,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=1,cumulative_adds=6,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=1} [junit4:junit4] 2> 15265 T334 oasu.DefaultSolrCoreState.decref SolrCoreState ref count has reached 0 - closing IndexWriter [junit4:junit4] 2> 15271 T334 oasu.DefaultSolrCoreState.decref Closing SolrCoreState - canceling any ongoing recovery [junit4:junit4] 2> 15282 T334 oas.SolrTestCaseJ4.tearDown ###Ending testRemoveOldLogs [junit4:junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestRecovery -Dtests.method=testRemoveOldLogs -Dtests.seed=60190B42E904DE2B -Dtests.slow=true -Dtests.locale=vi_VN -Dtests.timezone=Africa/Mbabane -Dtests.file.encoding=ISO-8859-1 [junit4:junit4] FAILURE 0.14s | TestRecovery.testRemoveOldLogs <<< [junit4:junit4] > Throwable #1: java.lang.AssertionError: expected:<0> but was:<1> [junit4:junit4] > at __randomizedtesting.SeedInfo.seed([60190B42E904DE2B:4185CAE9213E57D3]:0) [junit4:junit4] > at org.junit.Assert.fail(Assert.java:93) [junit4:junit4] > at org.junit.Assert.failNotEquals(Assert.java:647) [junit4:junit4] > at org.junit.Assert.assertEquals(Assert.java:128) [junit4:junit4] > at org.junit.Assert.assertEquals(Assert.java:472) [junit4:junit4] > at org.junit.Assert.assertEquals(Assert.java:456) [junit4:junit4] > at org.apache.solr.search.TestRecovery.testRemoveOldLogs(TestRecovery.java:721) [junit4:junit4] > at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method) [junit4:junit4] > at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:57) [junit4:junit4] > at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43) [junit4:junit4] > at java.lang.reflect.Method.invoke(Method.java:601) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1559) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.access$600(RandomizedRunner.java:79) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:737) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:773) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:787) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] > at org.apache.lucene.util.TestRuleSetupTeardownChained$1.evaluate(TestRuleSetupTeardownChained.java:50) [junit4:junit4] > at org.apache.lucene.util.TestRuleFieldCacheSanity$1.evaluate(TestRuleFieldCacheSanity.java:51) [junit4:junit4] > at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] > at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48) [junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] > at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl.forkTimeoutingTask(ThreadLeakControl.java:782) [junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$3.evaluate(ThreadLeakControl.java:442) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:746) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:648) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:682) [junit4:junit4] > at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:693) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesRestoreRule$1.evaluate(SystemPropertiesRestoreRule.java:53) [junit4:junit4] > at org.apache.lucene.util.AbstractBeforeAfterRule$1.evaluate(AbstractBeforeAfterRule.java:45) [junit4:junit4] > at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:42) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.NoShadowingOrOverridesOnMethodsRule$1.evaluate(NoShadowingOrOverridesOnMethodsRule.java:39) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] > at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:43) [junit4:junit4] > at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48) [junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreAfterMaxFailures$1.evaluate(TestRuleIgnoreAfterMaxFailures.java:70) [junit4:junit4] > at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:55) [junit4:junit4] > at com.carrotsearch.randomizedtesting.rules.StatementAdapter.evaluate(StatementAdapter.java:36) [junit4:junit4] > at com.carrotsearch.randomizedtesting.ThreadLeakControl$StatementRunner.run(ThreadLeakControl.java:358) [junit4:junit4] > at java.lang.Thread.run(Thread.java:722) [junit4:junit4] 2> 15336 T334 oas.SolrTestCaseJ4.deleteCore ###deleteCore [junit4:junit4] 2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog\tlog.0000000000000000016 FAILED !!!!! [junit4:junit4] 2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846\tlog FAILED !!!!! [junit4:junit4] 2> !!!! WARNING: best effort to remove C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build\solr-core\test\J0\.\solrtest-TestRecovery-1347553269846 FAILED !!!!! [junit4:junit4] 2> NOTE: test params are: codec=SimpleText, sim=RandomSimilarityProvider(queryNorm=false,coord=no): {}, locale=vi_VN, timezone=Africa/Mbabane [junit4:junit4] 2> NOTE: Windows 7 6.1 x86/Oracle Corporation 1.7.0_07 (32-bit)/cpus=2,threads=1,free=38319224,total=83427328 [junit4:junit4] 2> NOTE: All tests run in this JVM: [PreAnalyzedFieldTest, FieldAnalysisRequestHandlerTest, TestElisionMultitermQuery, TestDistributedGrouping, PathHierarchyTokenizerFactoryTest, SortByFunctionTest, SampleTest, XmlUpdateRequestHandlerTest, CSVRequestHandlerTest, HighlighterTest, SpatialFilterTest, TestRTGBase, TestDFRSimilarityFactory, ClusterStateTest, DebugComponentTest, IndexSchemaRuntimeFieldTest, SuggesterFSTTest, CurrencyFieldTest, TestDocSet, TestReload, TestJmxMonitoredMap, TestCodecSupport, TestLMDirichletSimilarityFactory, NotRequiredUniqueKeyTest, ReturnFieldsTest, WordBreakSolrSpellCheckerTest, DistributedQueryElevationComponentTest, SpellCheckCollatorTest, TermsComponentTest, TestFunctionQuery, TestFaceting, FastVectorHighlighterTest, TestRecovery] [junit4:junit4] Completed in 15.38s, 10 tests, 1 failure <<< FAILURES! [...truncated 600 lines...] BUILD FAILED C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\build.xml:29: The following error occurred while executing this line: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\solr\build.xml:146: The following error occurred while executing this line: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\module-build.xml:63: The following error occurred while executing this line: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:1133: The following error occurred while executing this line: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows\lucene\common-build.xml:810: There were test failures: 228 suites, 923 tests, 1 failure, 11 ignored (6 assumptions) Total time: 34 minutes 57 seconds Build step 'Invoke Ant' marked build as failure Recording test results Description set: Java: 32bit/jdk1.7.0_07 -client -XX:+UseSerialGC Email was triggered for: Failure Sending email for trigger: Failure ------=_Part_70_1413825912.1347554323915 Content-Type: text/plain; charset=us-ascii --------------------------------------------------------------------- To unsubscribe, e-mail: dev-unsubscribe@lucene.apache.org For additional commands, e-mail: dev-help@lucene.apache.org ------=_Part_70_1413825912.1347554323915--