Some Eclipse Foundation services are deprecated, or will be soon. Please ensure you've read this important communication.

Bug 317088

Summary:	Test failure on CloseableDoSFilterTest.testUnavailableIP()
Product:	[RT] Jetty	Reporter:	Joakim Erdfelt <joakim.erdfelt>
Component:	build	Assignee:	Greg Wilkins <gregw>
Status:	CLOSED WORKSFORME	QA Contact:
Severity:	normal
Priority:	P3	CC:	jetty-inbox, mgorovoy
Version:	7.1.3
Target Milestone:	7.1.x
Hardware:	PC
OS:	Linux
Whiteboard:

Description Joakim Erdfelt

2010-06-16 14:01:07 EDT

-------------------------------------------------------------------------------
Test set: org.eclipse.jetty.servlets.CloseableDoSFilterTest
-------------------------------------------------------------------------------
Tests run: 8, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 23.018 sec <<< FAILURE!
testUnavailableIP(org.eclipse.jetty.servlets.CloseableDoSFilterTest)  Time elapsed: 5.213 sec  <<< FAILURE!
java.lang.AssertionError: expected:<4> but was:<5>
	at org.junit.Assert.fail(Assert.java:91)
	at org.junit.Assert.failNotEquals(Assert.java:645)
	at org.junit.Assert.assertEquals(Assert.java:126)
	at org.junit.Assert.assertEquals(Assert.java:470)
	at org.junit.Assert.assertEquals(Assert.java:454)
	at org.eclipse.jetty.servlets.AbstractDoSFilterTest.testUnavailableIP(AbstractDoSFilterTest.java:228)
	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 org.junit.runners.model.FrameworkMethod$1.runReflectiveCall(FrameworkMethod.java:44)
	at org.junit.internal.runners.model.ReflectiveCallable.run(ReflectiveCallable.java:15)
	at org.junit.runners.model.FrameworkMethod.invokeExplosively(FrameworkMethod.java:41)
	at org.junit.internal.runners.statements.InvokeMethod.evaluate(InvokeMethod.java:20)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:76)
	at org.junit.runners.BlockJUnit4ClassRunner.runChild(BlockJUnit4ClassRunner.java:50)
	at org.junit.runners.ParentRunner$3.run(ParentRunner.java:193)
	at org.junit.runners.ParentRunner$1.schedule(ParentRunner.java:52)
	at org.junit.runners.ParentRunner.runChildren(ParentRunner.java:191)
	at org.junit.runners.ParentRunner.access$000(ParentRunner.java:42)
	at org.junit.runners.ParentRunner$2.evaluate(ParentRunner.java:184)
	at org.junit.internal.runners.statements.RunBefores.evaluate(RunBefores.java:28)
	at org.junit.internal.runners.statements.RunAfters.evaluate(RunAfters.java:31)
	at org.junit.runners.ParentRunner.run(ParentRunner.java:236)
	at org.apache.maven.surefire.junit4.JUnit4TestSet.execute(JUnit4TestSet.java:62)
	at org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.executeTestSet(AbstractDirectoryTestSuite.java:140)
	at org.apache.maven.surefire.suite.AbstractDirectoryTestSuite.execute(AbstractDirectoryTestSuite.java:127)
	at org.apache.maven.surefire.Surefire.run(Surefire.java:177)
	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 org.apache.maven.surefire.booter.SurefireBooter.runSuitesInProcess(SurefireBooter.java:338)
	at org.apache.maven.surefire.booter.SurefireBooter.main(SurefireBooter.java:997)

Comment 1 Joakim Erdfelt

2010-06-16 14:02:15 EDT

The console output was ...

Running org.eclipse.jetty.servlets.CloseableDoSFilterTest
2010-06-16 11:00:16.519:INFO::jetty-7.1.5-SNAPSHOT
2010-06-16 11:00:16.522:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:16.522:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:16.523:INFO::Started LocalConnector@0.0.0.0:0
2010-06-16 11:00:16.527:INFO::Started SelectChannelConnector@127.0.0.1:58770
2010-06-16 11:00:19.831:INFO::DoSFilter timer exited
2010-06-16 11:00:19.831:INFO::DoSFilter timer exited
2010-06-16 11:00:19.832:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:19.832:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:22.033:INFO::DoSFilter timer exited
2010-06-16 11:00:22.034:INFO::DoSFilter timer exited
2010-06-16 11:00:22.034:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:22.034:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:22.035:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:23.136:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:24.236:INFO::DoSFilter timer exited
2010-06-16 11:00:24.238:INFO::DoSFilter timer exited
2010-06-16 11:00:24.239:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:24.239:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:24.241:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:25.741:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:26.449:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:26.449:INFO::DoSFilter timer exited
2010-06-16 11:00:26.450:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:26.449:INFO::DoSFilter timer exited
2010-06-16 11:00:26.452:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:26.951:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:31.658:INFO::DoSFilter timer exited
2010-06-16 11:00:31.658:INFO::DoSFilter timer exited
2010-06-16 11:00:31.663:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:31.664:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:31.667:WARN::DOS ALERT: ip=127.0.0.1,session=50mvoz832xq5fu4wyd95uuxr,user=null
2010-06-16 11:00:32.767:WARN::DOS ALERT: ip=127.0.0.1,session=50mvoz832xq5fu4wyd95uuxr,user=null
2010-06-16 11:00:33.866:INFO::DoSFilter timer exited
2010-06-16 11:00:33.867:INFO::DoSFilter timer exited
2010-06-16 11:00:33.867:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:33.868:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:38.722:WARN::DOS ALERT: ip=127.0.0.1,session=9fq7uraj4jmv19c6s37it8jxz,user=null
2010-06-16 11:00:38.928:WARN::DOS ALERT: ip=127.0.0.1,session=x8l1tz4v6u601j22basrika9s,user=null
2010-06-16 11:00:39.273:INFO::DoSFilter timer exited
2010-06-16 11:00:39.273:INFO::DoSFilter timer exited
2010-06-16 11:00:39.274:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:39.275:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:39.476:INFO::DoSFilter timer exited
2010-06-16 11:00:39.476:INFO::DoSFilter timer exited
Tests run: 8, Failures: 1, Errors: 0, Skipped: 0, Time elapsed: 23.017 sec <<< FAILURE!

Comment 2 Joakim Erdfelt

2010-06-16 14:03:01 EDT

The STDERR reported for this specific test failure is as follows...

<system-err>2010-06-16 11:00:26.449:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:26.449:INFO::DoSFilter timer exited
2010-06-16 11:00:26.450:INFO::Whitelisted IP addresses: []
2010-06-16 11:00:26.449:INFO::DoSFilter timer exited
2010-06-16 11:00:26.452:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:26.951:WARN::DOS ALERT: ip=127.0.0.1,session=null,user=null
2010-06-16 11:00:31.658:INFO::DoSFilter timer exited
2010-06-16 11:00:31.658:INFO::DoSFilter timer exited
</system-err>

Comment 3 Joakim Erdfelt

2010-06-16 14:09:17 EDT

This error occurred during a full trunk build (mvn clean install), but subsequent builds did not trigger this failure.

Comment 4 Michael Gorovoy

2010-06-16 15:40:53 EDT

I've encountered similar errors in the past, and they similarly went away.

Comment 5 Joakim Erdfelt

2011-01-25 14:19:26 EST

This bug hasn't been able to be reproduced in the past 9 months.
Considering it closed.