You are viewing a plain text version of this content. The canonical link for it is here.
Posted to dev@lucene.apache.org by je...@sd-datasolutions.de on 2012/06/05 03:38:04 UTC

[JENKINS] Lucene-Solr-trunk-Windows-Java6-64 - Build # 420 - Failure!

Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-trunk-Windows-Java6-64/420/

1 tests failed.
REGRESSION:  org.apache.solr.handler.TestReplicationHandler.test

Error Message:
expected:<498> but was:<0>

Stack Trace:
java.lang.AssertionError: expected:<498> but was:<0>
	at __randomizedtesting.SeedInfo.seed([62E63199408F3D90:EAB20E43EE735068]: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.handler.TestReplicationHandler.doTestIndexAndConfigReplication(TestReplicationHandler.java:391)
	at org.apache.solr.handler.TestReplicationHandler.test(TestReplicationHandler.java:250)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:39)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:25)
	at java.lang.reflect.Method.invoke(Method.java:597)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.invoke(RandomizedRunner.java:1969)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$1100(RandomizedRunner.java:132)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$6.evaluate(RandomizedRunner.java:814)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$7.evaluate(RandomizedRunner.java:875)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$8.evaluate(RandomizedRunner.java:889)
	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:32)
	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.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
	at org.apache.lucene.util.TestRuleThreadAndTestName$1.evaluate(TestRuleThreadAndTestName.java:48)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSingleTest(RandomizedRunner.java:821)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$700(RandomizedRunner.java:132)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3$1.run(RandomizedRunner.java:669)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$3.evaluate(RandomizedRunner.java:695)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$4.evaluate(RandomizedRunner.java:734)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$5.evaluate(RandomizedRunner.java:745)
	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.TestRuleReportUncaughtExceptions$1.evaluate(TestRuleReportUncaughtExceptions.java:68)
	at org.apache.lucene.util.TestRuleStoreClassName$1.evaluate(TestRuleStoreClassName.java:38)
	at org.apache.lucene.util.TestRuleIcuHack$1.evaluate(TestRuleIcuHack.java:51)
	at com.carrotsearch.randomizedtesting.rules.SystemPropertiesInvariantRule$1.evaluate(SystemPropertiesInvariantRule.java:55)
	at org.apache.lucene.util.TestRuleNoInstanceHooksOverrides$1.evaluate(TestRuleNoInstanceHooksOverrides.java:53)
	at org.apache.lucene.util.TestRuleNoStaticHooksShadowing$1.evaluate(TestRuleNoStaticHooksShadowing.java:52)
	at org.apache.lucene.util.TestRuleAssertionsRequired$1.evaluate(TestRuleAssertionsRequired.java:36)
	at org.apache.lucene.util.TestRuleMarkFailure$1.evaluate(TestRuleMarkFailure.java:48)
	at org.apache.lucene.util.TestRuleIgnoreTestSuites$1.evaluate(TestRuleIgnoreTestSuites.java:56)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.runSuite(RandomizedRunner.java:605)
	at com.carrotsearch.randomizedtesting.RandomizedRunner.access$400(RandomizedRunner.java:132)
	at com.carrotsearch.randomizedtesting.RandomizedRunner$2.run(RandomizedRunner.java:551)




Build Log:
[...truncated 12669 lines...]
   [junit4]   2> 36222 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=segments_7} status=0 QTime=0 
   [junit4]   2> 36226 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_Lucene40_0.tim} status=0 QTime=0 
   [junit4]   2> 36230 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_Lucene40_0.frq} status=0 QTime=0 
   [junit4]   2> 36233 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.si} status=0 QTime=0 
   [junit4]   2> 36238 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fnm} status=0 QTime=2 
   [junit4]   2> 36241 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdt} status=0 QTime=0 
   [junit4]   2> 36242 T358 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
   [junit4]   2> 36244 T358 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042259\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe Trying to do a copy
   [junit4]   2> 36244 T358 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042259\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe (The system cannot find the path specified)
   [junit4]   2> 	at java.io.FileOutputStream.open(Native Method)
   [junit4]   2> 	at java.io.FileOutputStream.<init>(FileOutputStream.java:194)
   [junit4]   2> 	at java.io.FileOutputStream.<init>(FileOutputStream.java:145)
   [junit4]   2> 	at org.apache.solr.util.FileUtils.copyFile(FileUtils.java:48)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.copyAFile(SnapPuller.java:654)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.copyIndexFiles(SnapPuller.java:691)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:371)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:298)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller$1.run(SnapPuller.java:169)
   [junit4]   2> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
   [junit4]   2> 	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
   [junit4]   2> 	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
   [junit4]   2> 
   [junit4]   2> 36267 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36379 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36492 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36605 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36717 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36830 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 36942 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37054 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37166 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37269 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin} status=0 QTime=0 
   [junit4]   2> 37270 T358 oash.SnapPuller.fetchLatestIndex Master's generation: 7
   [junit4]   2> 37270 T358 oash.SnapPuller.fetchLatestIndex Slave's generation: 6
   [junit4]   2> 37270 T358 oash.SnapPuller.fetchLatestIndex Starting replication process
   [junit4]   2> 37272 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filelist&wt=javabin&generation=7} status=0 QTime=0 
   [junit4]   2> 37274 T358 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
   [junit4]   2> 37278 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_nrm.cfe} status=0 QTime=0 
   [junit4]   2> 37278 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37283 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdx} status=0 QTime=0 
   [junit4]   2> 37288 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_nrm.cfs} status=0 QTime=0 
   [junit4]   2> 37292 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_Lucene40_0.tip} status=0 QTime=0 
   [junit4]   2> 37296 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=segments_7} status=0 QTime=0 
   [junit4]   2> 37301 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_Lucene40_0.tim} status=0 QTime=0 
   [junit4]   2> 37305 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3_Lucene40_0.frq} status=0 QTime=0 
   [junit4]   2> 37310 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.si} status=0 QTime=0 
   [junit4]   2> 37315 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fnm} status=0 QTime=0 
   [junit4]   2> 37320 T342 C29 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdt} status=0 QTime=0 
   [junit4]   2> 37322 T358 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
   [junit4]   2> 37326 T358 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042300\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe Trying to do a copy
   [junit4]   2> 37327 T358 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042300\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-trunk-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1338859343739\slave\data\index.20120605042229\_3_nrm.cfe (The system cannot find the path specified)
   [junit4]   2> 	at java.io.FileOutputStream.open(Native Method)
   [junit4]   2> 	at java.io.FileOutputStream.<init>(FileOutputStream.java:194)
   [junit4]   2> 	at java.io.FileOutputStream.<init>(FileOutputStream.java:145)
   [junit4]   2> 	at org.apache.solr.util.FileUtils.copyFile(FileUtils.java:48)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.copyAFile(SnapPuller.java:654)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.copyIndexFiles(SnapPuller.java:691)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller.fetchLatestIndex(SnapPuller.java:371)
   [junit4]   2> 	at org.apache.solr.handler.ReplicationHandler.doFetch(ReplicationHandler.java:298)
   [junit4]   2> 	at org.apache.solr.handler.SnapPuller$1.run(SnapPuller.java:169)
   [junit4]   2> 	at java.util.concurrent.Executors$RunnableAdapter.call(Executors.java:441)
   [junit4]   2> 	at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:317)
   [junit4]   2> 	at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:150)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$101(ScheduledThreadPoolExecutor.java:98)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.runPeriodic(ScheduledThreadPoolExecutor.java:180)
   [junit4]   2> 	at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:204)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.runTask(ThreadPoolExecutor.java:886)
   [junit4]   2> 	at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:908)
   [junit4]   2> 	at java.lang.Thread.run(Thread.java:662)
   [junit4]   2> 
   [junit4]   2> 37389 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37501 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37613 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37726 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37838 T350 C30 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 37948 T291 oas.SolrTestCaseJ4.tearDown ###Ending test
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestReplicationHandler -Dtests.method=test -Dtests.seed=62E63199408F3D90 -Dtests.locale=hu_HU -Dtests.timezone=Asia/Tel_Aviv -Dargs="-Dfile.encoding=Cp1252"
   [junit4]   2>
   [junit4]    > (@AfterClass output)
   [junit4]   2> 37984 T291 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1338352377
   [junit4]   2> 37985 T291 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@12ada9e9
   [junit4]   2> 37988 T291 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 37989 T291 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=4,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=997,cumulative_deletesById=0,cumulative_deletesByQuery=2,cumulative_errors=0}
   [junit4]   2> 37991 T291 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 38044 T291 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1862362278
   [junit4]   2> 38045 T291 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@641990ca
   [junit4]   2> 38045 T291 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 38047 T291 oasu.DirectUpdateHandler2.close closing DirectUpdateHandler2{commits=8,autocommits=0,soft autocommits=0,optimizes=0,rollbacks=0,expungeDeletes=0,docsPending=0,adds=0,deletesById=0,deletesByQuery=0,errors=0,cumulative_adds=5,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 38048 T291 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 38116 T291 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=SimpleText, sim=RandomSimilarityProvider(queryNorm=true,coord=true): {}, locale=hu_HU, timezone=Asia/Tel_Aviv
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=2,threads=1,free=76519624,total=146997248
   [junit4]   2> NOTE: All tests run in this JVM: [WordBreakSolrSpellCheckerTest, DocumentAnalysisRequestHandlerTest, TestSuggestSpellingConverter, TestPropInjectDefaults, MoreLikeThisHandlerTest, SOLR749Test, StatsComponentTest, TestPorterStemFilterFactory, NotRequiredUniqueKeyTest, SampleTest, TestPatternReplaceFilterFactory, TestMappingCharFilterFactory, SuggesterFSTTest, RAMDirectoryFactoryTest, TestFrenchLightStemFilterFactory, TestArabicFilters, PluginInfoTest, MultiTermTest, DocumentBuilderTest, TestIndexingPerformance, TestLatvianStemFilterFactory, CloudStateUpdateTest, BasicZkTest, TestIndonesianStemFilterFactory, BadIndexSchemaTest, ZkSolrClientTest, TestDistributedSearch, TestUpdate, TestCapitalizationFilterFactory, TestThaiWordFilterFactory, NodeStateWatcherTest, TestArbitraryIndexDir, TestQueryUtils, TestCJKWidthFilterFactory, TestRussianLightStemFilterFactory, TestMultiWordSynonyms, TestDictionaryCompoundWordTokenFilterFactory, TestReplicationHandler]
   [junit4]   2> 
   [junit4] Completed in 38.12s, 1 test, 1 failure <<< FAILURES!
[...truncated 1017 lines...]

[...truncated 13787 lines...]

[...truncated 13787 lines...]

[...truncated 13787 lines...]