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/08 01:49:25 UTC
[JENKINS] Lucene-Solr-4.x-Windows-Java7-64 - Build # 14 - Still
Failing!
Build: http://jenkins.sd-datasolutions.de/job/Lucene-Solr-4.x-Windows-Java7-64/14/
1 tests failed.
FAILED: 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([5EAD18C5EF381272:D6F9271F41C47F8A]: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: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: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 13762 lines...]
[junit4] 2> 44892 T157 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 44897 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filelist&wt=javabin&generation=7} status=0 QTime=3
[junit4] 2> 44897 T157 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 44900 T140 C15 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> 44902 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 44906 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdx} status=0 QTime=0
[junit4] 2> 44912 T140 C15 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> 44917 T140 C15 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> 44922 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=segments_7} status=0 QTime=0
[junit4] 2> 44928 T140 C15 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> 44934 T140 C15 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> 44938 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.si} status=0 QTime=0
[junit4] 2> 44943 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fnm} status=0 QTime=0
[junit4] 2> 44950 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdt} status=0 QTime=0
[junit4] 2> 44951 T157 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 44954 T157 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013239\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_3_nrm.cfe Trying to do a copy
[junit4] 2> 44954 T157 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013239\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_3_nrm.cfe java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_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:212)
[junit4] 2> at java.io.FileOutputStream.<init>(FileOutputStream.java:165)
[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:471)
[junit4] 2> at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
[junit4] 2> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
[junit4] 2> at java.lang.Thread.run(Thread.java:722)
[junit4] 2>
[junit4] 2> 45025 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45149 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=1
[junit4] 2> 45271 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45395 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45517 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45641 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45765 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 45889 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=1
[junit4] 2> 45921 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=indexversion&wt=javabin} status=0 QTime=0
[junit4] 2> 45923 T157 oash.SnapPuller.fetchLatestIndex Master's generation: 7
[junit4] 2> 45923 T157 oash.SnapPuller.fetchLatestIndex Slave's generation: 6
[junit4] 2> 45923 T157 oash.SnapPuller.fetchLatestIndex Starting replication process
[junit4] 2> 45927 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filelist&wt=javabin&generation=7} status=0 QTime=2
[junit4] 2> 45927 T157 oash.SnapPuller.fetchLatestIndex Number of files in latest index in master: 10
[junit4] 2> 45932 T140 C15 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> 45938 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdx} status=0 QTime=0
[junit4] 2> 45942 T140 C15 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> 45947 T140 C15 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> 45952 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=segments_7} status=0 QTime=0
[junit4] 2> 45957 T140 C15 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> 45962 T140 C15 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> 45968 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.si} status=0 QTime=0
[junit4] 2> 45971 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fnm} status=0 QTime=0
[junit4] 2> 45977 T140 C15 REQ [collection1] webapp=/solr path=/replication params={command=filecontent&checksum=true&generation=7&wt=filestream&file=_3.fdt} status=0 QTime=0
[junit4] 2> 45979 T157 oash.SnapPuller.fetchLatestIndex Total time taken for download : 0 secs
[junit4] 2> 45981 T157 oash.SnapPuller.copyAFile SEVERE Unable to move index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013241\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_3_nrm.cfe Trying to do a copy
[junit4] 2> 45982 T157 oash.SnapPuller.copyAFile SEVERE Unable to copy index file from: .\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013241\_3_nrm.cfe to: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_3_nrm.cfe java.io.FileNotFoundException: C:\Jenkins\workspace\Lucene-Solr-4.x-Windows-Java7-64\solr\build\solr-core\test\J0\org.apache.solr.handler.TestReplicationHandler$SolrInstance-1339111915405\slave\data\index.20120608013204\_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:212)
[junit4] 2> at java.io.FileOutputStream.<init>(FileOutputStream.java:165)
[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:471)
[junit4] 2> at java.util.concurrent.FutureTask$Sync.innerRunAndReset(FutureTask.java:351)
[junit4] 2> at java.util.concurrent.FutureTask.runAndReset(FutureTask.java:178)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.access$301(ScheduledThreadPoolExecutor.java:178)
[junit4] 2> at java.util.concurrent.ScheduledThreadPoolExecutor$ScheduledFutureTask.run(ScheduledThreadPoolExecutor.java:293)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor.runWorker(ThreadPoolExecutor.java:1110)
[junit4] 2> at java.util.concurrent.ThreadPoolExecutor$Worker.run(ThreadPoolExecutor.java:603)
[junit4] 2> at java.lang.Thread.run(Thread.java:722)
[junit4] 2>
[junit4] 2> 46012 T149 C16 REQ [collection1] webapp=/solr path=/select params={wt=javabin&q=*:*&version=2} hits=0 status=0 QTime=0
[junit4] 2> 46132 T91 oas.SolrTestCaseJ4.tearDown ###Ending test
[junit4] 2> NOTE: reproduce with: ant test -Dtestcase=TestReplicationHandler -Dtests.method=test -Dtests.seed=5EAD18C5EF381272 -Dtests.locale=da -Dtests.timezone=Africa/Mbabane -Dargs="-Dfile.encoding=Cp1252"
[junit4] 2>
[junit4] > (@AfterClass output)
[junit4] 2> 46172 T91 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=2122250314
[junit4] 2> 46172 T91 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@1df0ce4d
[junit4] 2> 46173 T91 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 46174 T91 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> 46176 T91 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 46229 T91 oasc.CoreContainer.shutdown Shutting down CoreContainer instance=1197622463
[junit4] 2> 46230 T91 oasc.SolrCore.close [collection1] CLOSING SolrCore org.apache.solr.core.SolrCore@4a7b1d83
[junit4] 2> 46230 T91 oasc.SolrCore.closeSearcher [collection1] Closing main searcher on request.
[junit4] 2> 46232 T91 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> 46234 T91 oejsh.ContextHandler.doStop stopped o.e.j.s.ServletContextHandler{/solr,null}
[junit4] 2> 46356 T91 oas.SolrTestCaseJ4.deleteCore ###deleteCore
[junit4] 2> NOTE: test params are: codec=Lucene40: {}, sim=DefaultSimilarity, locale=da, timezone=Africa/Mbabane
[junit4] 2> NOTE: Windows 7 6.1 amd64/Oracle Corporation 1.7.0_04 (64-bit)/cpus=2,threads=1,free=63561016,total=209846272
[junit4] 2> NOTE: All tests run in this JVM: [TestWriterPerf, FieldAnalysisRequestHandlerTest, TestSolrQueryParser, TestFaceting, TestPatternReplaceFilterFactory, CoreAdminHandlerTest, FastVectorHighlighterTest, CopyFieldTest, NoCacheHeaderTest, SimpleFacetsTest, TestUtils, TestMultiWordSynonyms, TestTrie, TestRangeQuery, TestValueSourceCache, PrimUtilsTest, TestReversedWildcardFilterFactory, SolrPluginUtilsTest, TestHungarianLightStemFilterFactory, TestCJKTokenizerFactory, SolrInfoMBeanTest, TestStandardFactories, TestReplicationHandler]
[junit4] 2>
[junit4] Completed in 46.36s, 1 test, 1 failure <<< FAILURES!
[...truncated 1085 lines...]
[...truncated 14948 lines...]
[...truncated 14948 lines...]
[...truncated 14948 lines...]
[...truncated 14948 lines...]
[...truncated 14948 lines...]