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/09 13:00:48 UTC

[JENKINS] Lucene-Solr-4.x-Windows-Java6-64 - Build # 30 - Still Failing!

Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Windows-Java6-64/30/

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

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

Stack Trace:
java.lang.AssertionError: expected:<494> but was:<0>
	at __randomizedtesting.SeedInfo.seed([380ADC26CCF07716:B05EE3FC620C1AEE]: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.doTestIndexAndConfigAliasReplication(TestReplicationHandler.java:716)
	at org.apache.solr.handler.TestReplicationHandler.test(TestReplicationHandler.java:254)
	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 15612 lines...]
   [junit4]   2> 71696 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_nrm.cfe} status=0 QTime=0 
   [junit4]   2> 71704 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fnm} status=0 QTime=0 
   [junit4]   2> 71709 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_nrm.cfs} status=0 QTime=0 
   [junit4]   2> 71716 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fdt} status=0 QTime=0 
   [junit4]   2> 71719 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_Lucene40_0.tip} status=0 QTime=0 
   [junit4]   2> 71726 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.si} status=0 QTime=0 
   [junit4]   2> 71732 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fdx} status=0 QTime=0 
   [junit4]   2> 71737 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=segments_g} status=0 QTime=0 
   [junit4]   2> 71743 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_Lucene40_0.frq} status=0 QTime=0 
   [junit4]   2> 71744 T190 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
   [junit4]   2> 71747 T190 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064241\_9_Lucene40_0.tim to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim Trying to do a copy
   [junit4]   2> 71747 T190 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064241\_9_Lucene40_0.tim to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim (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> 71755 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=3 
   [junit4]   2> 71884 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72014 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72144 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72270 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72394 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72524 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72654 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=5 
   [junit4]   2> 72738 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin} status=0 QTime=0 
   [junit4]   2> 72739 T190 oash.SnapPuller.fetchLatestIndex Master's generation: 16
   [junit4]   2> 72739 T190 oash.SnapPuller.fetchLatestIndex Slave's generation: 15
   [junit4]   2> 72739 T190 oash.SnapPuller.fetchLatestIndex Starting replication process
   [junit4]   2> 72744 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filelist&wt=javabin&generation=16} status=0 QTime=1 
   [junit4]   2> 72744 T190 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
   [junit4]   2> 72749 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_Lucene40_0.tim} status=0 QTime=0 
   [junit4]   2> 72753 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_nrm.cfe} status=0 QTime=0 
   [junit4]   2> 72759 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fnm} status=0 QTime=0 
   [junit4]   2> 72765 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_nrm.cfs} status=0 QTime=0 
   [junit4]   2> 72770 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fdt} status=0 QTime=0 
   [junit4]   2> 72778 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_Lucene40_0.tip} status=0 QTime=0 
   [junit4]   2> 72779 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 72784 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.si} status=0 QTime=0 
   [junit4]   2> 72795 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9.fdx} status=0 QTime=0 
   [junit4]   2> 72799 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=segments_g} status=0 QTime=0 
   [junit4]   2> 72804 T173 C13 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=16&wt=filestream&file=_9_Lucene40_0.frq} status=0 QTime=0 
   [junit4]   2> 72808 T190 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
   [junit4]   2> 72812 T190 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064242\_9_Lucene40_0.tim to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim Trying to do a copy
   [junit4]   2> 72814 T190 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064242\_9_Lucene40_0.tim to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java6-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339238492938\slave\data\index.20120609064207\_9_Lucene40_0.tim (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> 72905 T183 C14 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0 
   [junit4]   2> 73027 T10 oas.SolrTestCaseJ4.tearDown ###Ending test
   [junit4]   1> replicate slave to master
   [junit4]   2> NOTE: reproduce with: ant test  -Dtestcase=TestReplicationHandler -Dtests.method=test -Dtests.seed=380ADC26CCF07716 -Dtests.locale=uk -Dtests.timezone=America/St_Kitts -Dargs="-Dfile.encoding=Cp1252"
   [junit4]   1> 
   [junit4]   2>
   [junit4]    > (@AfterClass output)
   [junit4]   2> 73081 T10 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1771190445
   [junit4]   2> 73081 T10 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@32a6faa9
   [junit4]   2> 73082 T10 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 73084 T10 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=0,cumulative_adds=494,cumulative_deletesById=0,cumulative_deletesByQuery=1,cumulative_errors=0}
   [junit4]   2> 73089 T10 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 73143 T10 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1222834702
   [junit4]   2> 73143 T10 oasc.SolrCore.close [collection1]  CLOSING SolrCore org.apache.solr.core.SolrCore@64598a5d
   [junit4]   2> 73144 T10 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
   [junit4]   2> 73146 T10 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=0,cumulative_deletesById=0,cumulative_deletesByQuery=0,cumulative_errors=0}
   [junit4]   2> 73148 T10 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
   [junit4]   2> 73228 T10 oas.SolrTestCaseJ4.deleteCore ###deleteCore
   [junit4]   2> NOTE: test params are: codec=Appending, sim=RandomSimilarityProvider(queryNorm=true,coord=false): {}, locale=uk, timezone=America/St_Kitts
   [junit4]   2> NOTE: Windows 7 6.1 amd64/Sun Microsystems Inc. 1.6.0_32 (64-bit)/cpus=2,threads=1,free=28438696,total=74776576
   [junit4]   2> NOTE: All tests run in this JVM: [TestReplicationHandler]
   [junit4]   2> 
   [junit4] Completed in 73.75s, 1 test, 1 failure <<< FAILURES!
[...truncated 1164 lines...]

[...truncated 16877 lines...]

[...truncated 16877 lines...]

[...truncated 16877 lines...]

[...truncated 16877 lines...]

[...truncated 16877 lines...]