Skip to content
[Jenkins]Jenkins
log in

Regression

com.ning.http.client.async.grizzly.GrizzlyMaxTotalConnectionTest.testMaxTotalConnections

Failing for the past 1 build (Since #1517 )
Took 2.3 sec.

Error Message

expected [null] but found [http://lenta.ru]

Stacktrace

java.lang.AssertionError: expected [null] but found [http://lenta.ru]
	at org.testng.Assert.fail(Assert.java:94)
	at org.testng.Assert.failNotSame(Assert.java:490)
	at org.testng.Assert.assertNull(Assert.java:426)
	at org.testng.Assert.assertNull(Assert.java:415)
	at com.ning.http.client.async.MaxTotalConnectionTest.testMaxTotalConnections(MaxTotalConnectionTest.java:103)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at org.testng.internal.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:84)
	at org.testng.internal.Invoker.invokeMethod(Invoker.java:714)
	at org.testng.internal.Invoker.invokeTestMethod(Invoker.java:901)
	at org.testng.internal.Invoker.invokeTestMethods(Invoker.java:1231)
	at org.testng.internal.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:127)
	at org.testng.internal.TestMethodWorker.run(TestMethodWorker.java:111)
	at org.testng.TestRunner.privateRun(TestRunner.java:767)
	at org.testng.TestRunner.run(TestRunner.java:617)
	at org.testng.SuiteRunner.runTest(SuiteRunner.java:348)
	at org.testng.SuiteRunner.runSequentially(SuiteRunner.java:343)
	at org.testng.SuiteRunner.privateRun(SuiteRunner.java:305)
	at org.testng.SuiteRunner.run(SuiteRunner.java:254)
	at org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
	at org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:86)
	at org.testng.TestNG.runSuitesSequentially(TestNG.java:1224)
	at org.testng.TestNG.runSuitesLocally(TestNG.java:1149)
	at org.testng.TestNG.run(TestNG.java:1057)
	at org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:76)
	at org.apache.maven.surefire.testng.TestNGDirectoryTestSuite.execute(TestNGDirectoryTestSuite.java:112)
	at org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:115)
	at sun.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
	at sun.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:62)
	at sun.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
	at java.lang.reflect.Method.invoke(Method.java:498)
	at org.apache.maven.surefire.util.ReflectionUtils.invokeMethodWithArray(ReflectionUtils.java:189)
	at org.apache.maven.surefire.booter.ProviderFactory$ProviderProxy.invoke(ProviderFactory.java:165)
	at org.apache.maven.surefire.booter.ProviderFactory.invokeProvider(ProviderFactory.java:85)
	at org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:103)
	at org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:74)

Standard Output

Configuring TestNG with: org.apache.maven.surefire.testng.conf.TestNGMapConfigurator@7dc5e7b4
07:00:39,857 |-INFO in ch.qos.logback.classic.LoggerContext[default] - Found resource [logback-test.xml] at [file:/home/jenkins/agent/workspace/Grizzly-AHC-master-nightly/target/test-classes/logback-test.xml]
07:00:39,937 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - debug attribute not set
07:00:39,938 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - About to instantiate appender of type [ch.qos.logback.core.ConsoleAppender]
07:00:39,946 |-INFO in ch.qos.logback.core.joran.action.AppenderAction - Naming appender as [CONSOLE]
07:00:39,996 |-WARN in ch.qos.logback.core.ConsoleAppender[CONSOLE] - This appender no longer admits a layout as a sub-component, set an encoder instead.
07:00:39,996 |-WARN in ch.qos.logback.core.ConsoleAppender[CONSOLE] - To ensure compatibility, wrapping your layout in LayoutWrappingEncoder.
07:00:39,996 |-WARN in ch.qos.logback.core.ConsoleAppender[CONSOLE] - See also http://logback.qos.ch/codes.html#layoutInsteadOfEncoder for details
07:00:39,997 |-INFO in ch.qos.logback.classic.joran.action.LoggerAction - Setting level of logger [org.eclipse] to INFO
07:00:39,997 |-INFO in ch.qos.logback.classic.joran.action.RootLoggerAction - Setting level of ROOT logger to DEBUG
07:00:39,997 |-INFO in ch.qos.logback.core.joran.action.AppenderRefAction - Attaching appender named [CONSOLE] to Logger[ROOT]
07:00:39,997 |-INFO in ch.qos.logback.classic.joran.action.ConfigurationAction - End of configuration.
07:00:39,999 |-INFO in ch.qos.logback.classic.joran.JoranConfigurator@76b0bfab - Registering current configuration as safe fallback point

2023-04-18 07:00:40,072 [main] INFO org.eclipse.jetty.util.log - Logging initialized @585ms to org.eclipse.jetty.util.log.Slf4jLog
2023-04-18 07:00:40,226 [main] INFO org.eclipse.jetty.server.Server - jetty-9.4.17.v20190418; built: 2019-04-18T19:45:35.259Z; git: aa1c656c315c011c01e7b21aabb04066635b9f67; jvm 1.8.0_202-b08
2023-04-18 07:00:40,267 [main] INFO org.eclipse.jetty.server.AbstractConnector - Started ServerConnector@1a38c59b{HTTP/1.1,[http/1.1]}{127.0.0.1:39353}
2023-04-18 07:00:40,268 [main] INFO org.eclipse.jetty.server.AbstractConnector - Started ServerConnector@55040f2f{HTTP/1.1,[http/1.1]}{127.0.0.1:45657}
2023-04-18 07:00:40,268 [main] INFO org.eclipse.jetty.server.Server - Started @785ms
2023-04-18 07:00:40,268 [main] INFO com.ning.http.client.async.AbstractBasicTest - Local HTTP server started successfully
2023-04-18 07:00:40,763 [grizzly-ahc-kernel(1) SelectorRunner] DEBUG com.ning.http.client.providers.grizzly.AsyncHttpClientFilter - REQUEST: HttpRequestPacket (
   method=GET
   url=/
   query=null
   protocol=HTTP/1.1
   content-length=-1
   headers=[
      Host=google.com
      User-Agent=AHC/1.0
      Connection=close
      Accept=*/*]
)
2023-04-18 07:00:40,811 [AsyncHttpClient-Callback] DEBUG com.ning.http.client.providers.grizzly.AhcEventFilter - RESPONSE: HttpResponsePacket (
  status=301
  reason=Moved Permanently
  protocol=HTTP/1.1
  content-length=219
  committed=false
  headers=[
      location=http://www.google.com/
      content-type=text/html; charset=UTF-8
      content-security-policy-report-only=object-src 'none';base-uri 'self';script-src 'nonce-l196IBX1tceyVV6V_tYQ2A' 'strict-dynamic' 'report-sample' 'unsafe-eval' 'unsafe-inline' https: http:;report-uri https://csp.withgoogle.com/csp/gws/other-hp
      date=Tue, 18 Apr 2023 07:00:40 GMT
      expires=Thu, 18 May 2023 07:00:40 GMT
      cache-control=public, max-age=2592000
      server=gws
      content-length=219
      x-xss-protection=0
      x-frame-options=SAMEORIGIN
      connection=close]
)
2023-04-18 07:00:42,635 [connection-pool-delays-thread-pool(1)] DEBUG com.ning.http.client.AsyncCompletionHandlerBase - Poll timeout expired
java.util.concurrent.TimeoutException: Poll timeout expired
	at org.glassfish.grizzly.connectionpool.SingleEndpointPool$AsyncPollTimeoutWorker.doWork(SingleEndpointPool.java:1509)
	at org.glassfish.grizzly.connectionpool.SingleEndpointPool$AsyncPollTimeoutWorker.doWork(SingleEndpointPool.java:1486)
	at org.glassfish.grizzly.utils.DelayedExecutor$DelayedRunnable.run(DelayedExecutor.java:159)
	at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.doWork(AbstractThreadPool.java:593)
	at org.glassfish.grizzly.threadpool.AbstractThreadPool$Worker.run(AbstractThreadPool.java:573)
	at java.lang.Thread.run(Thread.java:748)