Generated by TestNG with ReportNG at 12:08 PDT on Monday 25 April 2022
root@1bc69cf4cb94 / Java 17.0.2 (Private Build) / Linux 4.14.186-146.268.amzn2.x86_64 (amd64)

Testing state of JaXMPP instance after issues with connection or authentication timeout - #4378

Suites · Log Output

Test duration : 110.061s

Failed Configuration
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
setupSuite 110.061s Method arguments: org.testng.TestRunner@548e76f1
2022-04-25 12:21:45 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-25 12:21:45 | admin :: admin@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-25 12:21:45 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-25 12:21:45 | admin :: admin@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-25 12:22:05 | Could not connect with admin account credentials (tigase.jaxmpp.core.client.exceptions.JaxmppException: javax.net.ssl.SSLException: Unsupported or unrecognized SSL message), trying to register account...

2022-04-25 12:22:05 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@e94aa1a

2022-04-25 12:22:05 | StateChangedEvent{oldState=null, newState=connecting}

2022-04-25 12:22:05 | [Mutex] waiting for: [registration]

2022-04-25 12:22:05 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5355b8

2022-04-25 12:22:05 | StateChangedEvent{oldState=connecting, newState=connected}

2022-04-25 12:22:05 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@46cc16a

2022-04-25 12:22:05 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2022-04-25 12:22:05 | admin :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-25 12:22:05 | StanzaReceivedEvent{stanza=<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>}

2022-04-25 12:22:05 | admin :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-25 12:22:05 | StanzaSendingEvent{stanza=<starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>}

2022-04-25 12:22:25 | ErrorEvent{condition=null, caught=javax.net.ssl.SSLException: Unsupported or unrecognized SSL message, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@167e3da0}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@416e5f83}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@27222af8}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@6a01f9ce}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@70e59fa3}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@12606744}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=test-domain.com}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=admin}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Mon Apr 25 12:22:25 PDT 2022}}}}

2022-04-25 12:22:25 | StateChangedEvent{oldState=connected, newState=disconnected}

2022-04-25 12:22:25 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2141a0cc

2022-04-25 12:22:25 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@44ebe2a3

2022-04-25 12:22:25 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@18af751a

2022-04-25 12:23:35 | [Mutex] timeout. Not received [registration]

2022-04-25 12:23:35 | [Mutex] isItemNotified: registrationSuccess :: false

java.lang.AssertionError: Registration failed!
org.testng.AssertJUnit.fail(AssertJUnit.java:65)
org.testng.AssertJUnit.assertTrue(AssertJUnit.java:23)
tigase.tests.utils.AccountsManager.registerAccount(AccountsManager.java:195)
tigase.tests.utils.AccountBuilder.build(AccountBuilder.java:123)
tigase.tests.AbstractTest.ensureAdminAccountExists(AbstractTest.java:474)
tigase.tests.AbstractTest.setupSuite(AbstractTest.java:779)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke0(Native Method)
java.base/jdk.internal.reflect.NativeMethodAccessorImpl.invoke(NativeMethodAccessorImpl.java:77)
java.base/jdk.internal.reflect.DelegatingMethodAccessorImpl.invoke(DelegatingMethodAccessorImpl.java:43)
java.base/java.lang.reflect.Method.invoke(Method.java:568)
org.testng.internal.invokers.MethodInvocationHelper.invokeMethod(MethodInvocationHelper.java:135)
org.testng.internal.invokers.MethodInvocationHelper.invokeMethodConsideringTimeout(MethodInvocationHelper.java:65)
org.testng.internal.invokers.ConfigInvoker.invokeConfigurationMethod(ConfigInvoker.java:381)
org.testng.internal.invokers.ConfigInvoker.invokeConfigurations(ConfigInvoker.java:319)
org.testng.SuiteRunner.privateRun(SuiteRunner.java:368)
org.testng.SuiteRunner.run(SuiteRunner.java:326)
org.testng.SuiteRunnerWorker.runSuite(SuiteRunnerWorker.java:52)
org.testng.SuiteRunnerWorker.run(SuiteRunnerWorker.java:95)
org.testng.TestNG.runSuitesSequentially(TestNG.java:1249)
org.testng.TestNG.runSuitesLocally(TestNG.java:1169)
org.testng.TestNG.runSuites(TestNG.java:1092)
org.testng.TestNG.run(TestNG.java:1060)
org.apache.maven.surefire.testng.TestNGExecutor.run(TestNGExecutor.java:283)
org.apache.maven.surefire.testng.TestNGXmlTestSuite.execute(TestNGXmlTestSuite.java:75)
org.apache.maven.surefire.testng.TestNGProvider.invoke(TestNGProvider.java:120)
org.apache.maven.surefire.booter.ForkedBooter.invokeProviderInSameClassLoader(ForkedBooter.java:384)
org.apache.maven.surefire.booter.ForkedBooter.runSuitesInProcess(ForkedBooter.java:345)
org.apache.maven.surefire.booter.ForkedBooter.execute(ForkedBooter.java:126)
org.apache.maven.surefire.booter.ForkedBooter.main(ForkedBooter.java:418)
 
Skipped Configuration
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
setUp 0.000s
setUp 0.000s
setUp 0.000s
setUp 0.000s
setUp 0.000s
setUp 0.000s
setupClass 0.000s
setupMethod 0.000s
setupMethod 0.000s
setupMethod 0.000s
setupMethod 0.000s
setupMethod 0.000s
setupMethod 0.000s
tearDownClass 0.000s
tearDownMethod 0.000s
tearDownMethod 0.000s
tearDownMethod 0.000s
tearDownMethod 0.000s
tearDownMethod 0.000s
tearDownMethod 0.000s
tearDownSuite 0.000s
Skipped Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 0.000s
2022-04-25 12:23:35 |

2022-04-25 12:23:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-25 12:23:35 | ------------------------------------

testStateAfterAuthTimeoutSocket 0.000s
2022-04-25 12:23:35 |

2022-04-25 12:23:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-25 12:23:35 | ------------------------------------

testStateAfterAuthTimeoutWebSocket 0.000s
2022-04-25 12:23:35 |

2022-04-25 12:23:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-25 12:23:35 | ------------------------------------

testStateAfterConnectionFailureBosh 0.000s
2022-04-25 12:23:35 |

2022-04-25 12:23:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-25 12:23:35 | ------------------------------------

testStateAfterConnectionFailureSocket 0.000s
2022-04-25 12:23:35 |

2022-04-25 12:23:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-25 12:23:35 | ------------------------------------

testStateAfterConnectionFailureWebSocket 0.000s