Test duration : 102.941s
| Failed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 40.117s |
2022-10-13 23:17:03 |
java.lang.AssertionError: expected [true] but found [false]
2022-10-13 23:17:03 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:17:03 | ------------------------------------ 2022-10-13 23:17:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:17:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:17:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-10-13 23:17:23 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2022-10-13 23:17:23 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:17:23 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:17:23 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-10-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200
org.testng.Assert.fail(Assert.java:110)
org.testng.Assert.failNotEquals(Assert.java:1413) org.testng.Assert.assertTrue(Assert.java:56) org.testng.Assert.assertTrue(Assert.java:66) tigase.tests.jaxmpp.TestHandlingOfConnectionIssues.testStateAfterAuthTimeout(TestHandlingOfConnectionIssues.java:122) tigase.tests.jaxmpp.TestHandlingOfConnectionIssues.testStateAfterAuthTimeoutBosh(TestHandlingOfConnectionIssues.java:51) 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.TestInvoker.invokeMethod(TestInvoker.java:673) org.testng.internal.invokers.TestInvoker.invokeTestMethod(TestInvoker.java:220) org.testng.internal.invokers.MethodRunner.runInSequence(MethodRunner.java:50) org.testng.internal.invokers.TestInvoker$MethodInvocationAgent.invoke(TestInvoker.java:945) org.testng.internal.invokers.TestInvoker.invokeTestMethods(TestInvoker.java:193) org.testng.internal.invokers.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:146) org.testng.internal.invokers.TestMethodWorker.run(TestMethodWorker.java:128) java.base/java.util.ArrayList.forEach(ArrayList.java:1511) org.testng.TestRunner.privateRun(TestRunner.java:808) org.testng.TestRunner.run(TestRunner.java:603) org.testng.SuiteRunner.runTest(SuiteRunner.java:429) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:423) org.testng.SuiteRunner.privateRun(SuiteRunner.java:383) 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) |
| testStateAfterConnectionFailureBosh | 20.125s |
2022-10-13 23:18:24 |
java.lang.AssertionError: expected [true] but found [false]
2022-10-13 23:18:24 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:18:24 | ------------------------------------ 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200
org.testng.Assert.fail(Assert.java:110)
org.testng.Assert.failNotEquals(Assert.java:1413) org.testng.Assert.assertTrue(Assert.java:56) org.testng.Assert.assertTrue(Assert.java:66) tigase.tests.jaxmpp.TestHandlingOfConnectionIssues.testStateAfterConnectionFailure(TestHandlingOfConnectionIssues.java:175) tigase.tests.jaxmpp.TestHandlingOfConnectionIssues.testStateAfterConnectionFailureBosh(TestHandlingOfConnectionIssues.java:66) 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.TestInvoker.invokeMethod(TestInvoker.java:673) org.testng.internal.invokers.TestInvoker.invokeTestMethod(TestInvoker.java:220) org.testng.internal.invokers.MethodRunner.runInSequence(MethodRunner.java:50) org.testng.internal.invokers.TestInvoker$MethodInvocationAgent.invoke(TestInvoker.java:945) org.testng.internal.invokers.TestInvoker.invokeTestMethods(TestInvoker.java:193) org.testng.internal.invokers.TestMethodWorker.invokeTestMethods(TestMethodWorker.java:146) org.testng.internal.invokers.TestMethodWorker.run(TestMethodWorker.java:128) java.base/java.util.ArrayList.forEach(ArrayList.java:1511) org.testng.TestRunner.privateRun(TestRunner.java:808) org.testng.TestRunner.run(TestRunner.java:603) org.testng.SuiteRunner.runTest(SuiteRunner.java:429) org.testng.SuiteRunner.runSequentially(SuiteRunner.java:423) org.testng.SuiteRunner.privateRun(SuiteRunner.java:383) 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) |
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutSocket | 20.244s |
2022-10-13 23:17:43 |
2022-10-13 23:17:43 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:17:43 | ------------------------------------ 2022-10-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: null->connecting 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222] 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: connecting->connected 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms 2022-10-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:17:43 | >> <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:17:43 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4046] Start TLS 2022-10-13 23:17:43 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:17:43 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4048] Proceeding TLS 2022-10-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4048] Start handshake 2022-10-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:17:43 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:17:43 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4048] Connector state changed: connected->disconnected 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4048] Stream terminated 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: null->connecting 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: localhost:5222 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222] 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connecting->connected 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4046] Start TLS 2022-10-13 23:18:03 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4053] Proceeding TLS 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4053] Start handshake 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-10-13 23:18:03 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2oyMTR3MDA1NjAscj1NRlV1a29IbmgyMVQ1Y0l5ZVFCdA==</auth> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2oyMTR3MDA1NjAscj1NRlV1a29IbmgyMVQ1Y0l5ZVFCdA==</auth> 2022-10-13 23:18:03 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NRlV1a29IbmgyMVQ1Y0l5ZVFCdEtMU2RtcUVxWGVXZ0JjZXdZOWN2LHM9emoxbmxnMFcxZjN5YkE9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NRlV1a29IbmgyMVQ1Y0l5ZVFCdEtMU2RtcUVxWGVXZ0JjZXdZOWN2LHM9emoxbmxnMFcxZjN5YkE9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:03 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TUZVdWtvSG5oMjFUNWNJeWVRQnRLTFNkbXFFcVhlV2dCY2V3WTljdixwPTBIODRrdFY2dnBzTFJ0cXFRNTRqMEtvQjJKZDNQY0x5b3BEUkt4WXRrOFE9</response> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TUZVdWtvSG5oMjFUNWNJeWVRQnRLTFNkbXFFcVhlV2dCY2V3WTljdixwPTBIODRrdFY2dnBzTFJ0cXFRNTRqMEtvQjJKZDNQY0x5b3BEUkt4WXRrOFE9</response> 2022-10-13 23:18:03 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wenNicVpmL2REUG1LdjNlT3hLMXRhYS9zNFBDbWt0VExFeUtlVUZWcFVJPQ==</success> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wenNicVpmL2REUG1LdjNlT3hLMXRhYS9zNFBDbWt0VExFeUtlVUZWcFVJPQ==</success> 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="bXm4v2vdvhQTTMZmMFzbClY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <iq xmlns="jabber:client" id="bXm4v2vdvhQTTMZmMFzbClY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="sGvydIKBBfNFIyiY7zcLyxh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <iq xmlns="jabber:client" id="sGvydIKBBfNFIyiY7zcLyxh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="J1ui1fzp6pVQ7CiHDjSR0kL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com >> <iq xmlns="jabber:client" id="J1ui1fzp6pVQ7CiHDjSR0kL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:03 | >> <iq id="bXm4v2vdvhQTTMZmMFzbClY" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324</jid></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com << <iq id="bXm4v2vdvhQTTMZmMFzbClY" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324</jid></bind></iq> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="8RYCp9m5cPRNR0dx4zw6jRL" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324 >> <iq xmlns="jabber:client" id="8RYCp9m5cPRNR0dx4zw6jRL" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | >> <iq id="sGvydIKBBfNFIyiY7zcLyxh" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325</jid></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-324 << <iq id="sGvydIKBBfNFIyiY7zcLyxh" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325</jid></bind></iq> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="F4zBx8Di1fzp6pVQ7CiHDjS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325 >> <iq xmlns="jabber:client" id="F4zBx8Di1fzp6pVQ7CiHDjS" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | >> <iq id="J1ui1fzp6pVQ7CiHDjSR0kL" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326</jid></bind></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325 << <iq id="J1ui1fzp6pVQ7CiHDjSR0kL" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326</jid></bind></iq> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:03 | << <iq xmlns="jabber:client" id="w1obLzrXiICCp9m5cPRNR0d" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq xmlns="jabber:client" id="w1obLzrXiICCp9m5cPRNR0d" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:03 | >> <iq id="8RYCp9m5cPRNR0dx4zw6jRL" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <iq id="8RYCp9m5cPRNR0dx4zw6jRL" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"/> 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:03 | << <iq to="test-domain.com" id="pMDFzbClYgDFn3bKCqeDBgT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq to="test-domain.com" id="pMDFzbClYgDFn3bKCqeDBgT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:03 | >> <iq id="F4zBx8Di1fzp6pVQ7CiHDjS" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <iq id="F4zBx8Di1fzp6pVQ7CiHDjS" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-325"/> 2022-10-13 23:18:03 | << <iq id="5OH4gIONVUbodDlXcBjCFIu" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq id="5OH4gIONVUbodDlXcBjCFIu" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | >> <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="3ec5592f-c34b-47af-81db-17727eafba22" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="3ec5592f-c34b-47af-81db-17727eafba22" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:03 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | >> <iq id="w1obLzrXiICCp9m5cPRNR0d" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"/> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <iq id="w1obLzrXiICCp9m5cPRNR0d" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"/> 2022-10-13 23:18:03 | << <iq to="test-domain.com" id="rZcJIxm2bLzrXiICCp9m5cP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq to="test-domain.com" id="rZcJIxm2bLzrXiICCp9m5cP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | << <iq to="test-domain.com" id="8X4ONVUbodDlXcBjCFIu5pR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq to="test-domain.com" id="8X4ONVUbodDlXcBjCFIu5pR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:03 | << <iq id="UaFGtbp4fMSR7hRNY4k2fPI" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq id="UaFGtbp4fMSR7hRNY4k2fPI" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | << <iq id="hSL5s7lGNY07tZezqarhBv5" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <iq id="hSL5s7lGNY07tZezqarhBv5" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | >> <iq id="5OH4gIONVUbodDlXcBjCFIu" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <iq id="5OH4gIONVUbodDlXcBjCFIu" type="result" xmlns="jabber:client" to="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:03 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:03 | >> <presence xmlns="jabber:client" from="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326" to="jaxmpp__j214w00560@test-domain.com"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326 << <presence xmlns="jabber:client" from="jaxmpp__j214w00560@test-domain.com/1608752850-tigase-326" to="jaxmpp__j214w00560@test-domain.com"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connected->disconnecting 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4053] Connector state changed: disconnecting->disconnected |
| testStateAfterAuthTimeoutWebSocket | 20.367s |
2022-10-13 23:18:03 |
2022-10-13 23:18:03 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:18:03 | ------------------------------------ 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-10-13 23:18:03 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:03 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:03 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-10-13 23:18:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:23 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:23 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-10-13 23:18:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-10-13 23:18:23 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FzNXhweTA1NjEscj1wcTZyWFBrSU9ZZ0RKbWhkZWdXVw==</auth> 2022-10-13 23:18:23 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FzNXhweTA1NjEscj1wcTZyWFBrSU9ZZ0RKbWhkZWdXVw==</auth> 2022-10-13 23:18:23 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wcTZyWFBrSU9ZZ0RKbWhkZWdXVzlCaVpqYk5rMG5FY1VLOW5vMzRLLHM9djBQREtvblFtMXhzNVE9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:23 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wcTZyWFBrSU9ZZ0RKbWhkZWdXVzlCaVpqYk5rMG5FY1VLOW5vMzRLLHM9djBQREtvblFtMXhzNVE9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:24 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHE2clhQa0lPWWdESm1oZGVnV1c5QmlaamJOazBuRWNVSzlubzM0SyxwPVk5TkdQWWoyZDdFVy9pMVlKU2dXS2ZncGpLcnAvQWFCRG8yRXVXdVg2SVU9</response> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cHE2clhQa0lPWWdESm1oZGVnV1c5QmlaamJOazBuRWNVSzlubzM0SyxwPVk5TkdQWWoyZDdFVy9pMVlKU2dXS2ZncGpLcnAvQWFCRG8yRXVXdVg2SVU9</response> 2022-10-13 23:18:24 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1xd25ReERjV0o1MW1kTEdPWXJUSzVkcDU1ek9tR2o5cmxhUUlabHFuWEVjPQ==</success> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1xd25ReERjV0o1MW1kTEdPWXJUSzVkcDU1ek9tR2o5cmxhUUlabHFuWEVjPQ==</success> 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:24 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="X6jXaraEpdtfzwawq1nOZ0r" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com >> <iq xmlns="jabber:client" id="X6jXaraEpdtfzwawq1nOZ0r" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="jatrZYn8kLLzoT4s1rV9n8o" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com >> <iq xmlns="jabber:client" id="jatrZYn8kLLzoT4s1rV9n8o" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="5YRoU0oXfytYnXZfMLDgXiE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com >> <iq xmlns="jabber:client" id="5YRoU0oXfytYnXZfMLDgXiE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:24 | >> <iq id="X6jXaraEpdtfzwawq1nOZ0r" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-327"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-327</jid></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <iq id="X6jXaraEpdtfzwawq1nOZ0r" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-327"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-327</jid></bind></iq> 2022-10-13 23:18:24 | >> <iq id="jatrZYn8kLLzoT4s1rV9n8o" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-328"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-328</jid></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <iq id="jatrZYn8kLLzoT4s1rV9n8o" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-328"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-328</jid></bind></iq> 2022-10-13 23:18:24 | >> <iq id="5YRoU0oXfytYnXZfMLDgXiE" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329</jid></bind></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com << <iq id="5YRoU0oXfytYnXZfMLDgXiE" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329</jid></bind></iq> 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="weBBBfNFIyiY7zcLyxhDxmV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq xmlns="jabber:client" id="weBBBfNFIyiY7zcLyxhDxmV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="732yu9Dk14zlLNSX12voQNP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq xmlns="jabber:client" id="732yu9Dk14zlLNSX12voQNP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | << <iq xmlns="jabber:client" id="R30i1qUV5dGteMFJvjHMGyu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq xmlns="jabber:client" id="R30i1qUV5dGteMFJvjHMGyu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:24 | >> <iq id="weBBBfNFIyiY7zcLyxhDxmV" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 << <iq id="weBBBfNFIyiY7zcLyxhDxmV" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | >> <iq id="732yu9Dk14zlLNSX12voQNP" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 << <iq id="732yu9Dk14zlLNSX12voQNP" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | >> <iq id="R30i1qUV5dGteMFJvjHMGyu" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 << <iq id="R30i1qUV5dGteMFJvjHMGyu" type="result" xmlns="jabber:client" to="jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329"/> 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:24 | << <iq to="test-domain.com" id="p1S9x7u5sezx7x9GuaIBx8D" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq to="test-domain.com" id="p1S9x7u5sezx7x9GuaIBx8D" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | << <iq to="test-domain.com" id="gbk1jU19i1qUV5dGteMFJvj" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq to="test-domain.com" id="gbk1jU19i1qUV5dGteMFJvj" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | << <iq to="test-domain.com" id="Zfun2oTbp7j08siLRMVSbzd" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq to="test-domain.com" id="Zfun2oTbp7j08siLRMVSbzd" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:24 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:24 | << <iq id="m0JbKydFn07wmP39BhW0cMJ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq id="m0JbKydFn07wmP39BhW0cMJ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | << <iq id="ZhxscIxtZhDEq2s5v4v2vdv" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq id="ZhxscIxtZhDEq2s5v4v2vdv" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | << <iq id="R97vrgAhNDw9Au5zbFpcweQ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <iq id="R97vrgAhNDw9Au5zbFpcweQ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:24 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-10-13 23:18:24 | >> <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="69968aff-ce27-47d7-8e95-ec45dcdf6bca" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:24 | jaxmpp_ :: jaxmpp__qs5xpy0561@test-domain.com/1608752850-tigase-329 << <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="69968aff-ce27-47d7-8e95-ec45dcdf6bca" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:24 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-10-13 23:18:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-10-13 23:18:27 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterConnectionFailureSocket | 0.305s |
2022-10-13 23:18:44 |
2022-10-13 23:18:44 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:18:44 | ------------------------------------ 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: null->connecting 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] DNS entry stored in session object: missing:5222 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222] 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing: Name or service not known. Trying next. 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: connecting->disconnected 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: null->connecting 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] DNS entry stored in session object: localhost:5222 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222] 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connecting->connected 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:44 | >> <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4095] Start TLS 2022-10-13 23:18:44 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4099] Proceeding TLS 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4099] Start handshake 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:44 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-10-13 23:18:44 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX201dGlydDA1NjMscj1ad25CaE9YRWVSaGl6MEo1R3ZyeA==</auth> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX201dGlydDA1NjMscj1ad25CaE9YRWVSaGl6MEo1R3ZyeA==</auth> 2022-10-13 23:18:44 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ad25CaE9YRWVSaGl6MEo1R3ZyeGVvbUc0QXgzbzAzZ3RhOXcyS3BQLHM9SHM3akVyd21PZGlCN3c9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ad25CaE9YRWVSaGl6MEo1R3ZyeGVvbUc0QXgzbzAzZ3RhOXcyS3BQLHM9SHM3akVyd21PZGlCN3c9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:44 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WnduQmhPWEVlUmhpejBKNUd2cnhlb21HNEF4M28wM2d0YTl3MktwUCxwPWhNc0RKL1grNVVNTDRkOHpnNENpS0FZcklOa2hsOWs0Wi84dWxQb0R5a0E9</response> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WnduQmhPWEVlUmhpejBKNUd2cnhlb21HNEF4M28wM2d0YTl3MktwUCxwPWhNc0RKL1grNVVNTDRkOHpnNENpS0FZcklOa2hsOWs0Wi84dWxQb0R5a0E9</response> 2022-10-13 23:18:44 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ScUI2ME94TCtpMVZhcE9EZlE2RzdYQmZlZzZsKytqa3RRRUNvalB2Q0NvPQ==</success> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ScUI2ME94TCtpMVZhcE9EZlE2RzdYQmZlZzZsKytqa3RRRUNvalB2Q0NvPQ==</success> 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:44 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:44 | << <iq xmlns="jabber:client" id="PrL07eTaoT15qXcIxtZhDEq" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com >> <iq xmlns="jabber:client" id="PrL07eTaoT15qXcIxtZhDEq" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:44 | >> <iq id="PrL07eTaoT15qXcIxtZhDEq" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330</jid></bind></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com << <iq id="PrL07eTaoT15qXcIxtZhDEq" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330</jid></bind></iq> 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:44 | << <iq xmlns="jabber:client" id="8muDrdulIRVV7wfBcP28nZ1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 >> <iq xmlns="jabber:client" id="8muDrdulIRVV7wfBcP28nZ1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:44 | >> <iq id="8muDrdulIRVV7wfBcP28nZ1" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"/> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <iq id="8muDrdulIRVV7wfBcP28nZ1" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"/> 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:44 | << <iq to="test-domain.com" id="koyuYn8kLLzoT4s1rV9n8oY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="koyuYn8kLLzoT4s1rV9n8oY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:44 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:44 | >> <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="c5a2a486-4625-45c0-8b01-553ed7add256" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <enabled location="ed1b7dd8a1b3" max="60" resume="true" id="c5a2a486-4625-45c0-8b01-553ed7add256" xmlns="urn:xmpp:sm:3"/> 2022-10-13 23:18:44 | << <iq id="PuO6jCFIu5pRY3o6j15t1qY" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 >> <iq id="PuO6jCFIu5pRY3o6j15t1qY" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:44 | >> <iq id="koyuYn8kLLzoT4s1rV9n8oY" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12128/cccf702b" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12128/cccf702b" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <iq id="koyuYn8kLLzoT4s1rV9n8oY" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12128/cccf702b" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12128/cccf702b" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-10-13 23:18:44 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:44 | >> <iq id="PuO6jCFIu5pRY3o6j15t1qY" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <iq id="PuO6jCFIu5pRY3o6j15t1qY" type="result" xmlns="jabber:client" to="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connected->disconnecting 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:44 | >> <presence xmlns="jabber:client" from="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330" to="jaxmpp__m5tirt0563@test-domain.com"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <presence xmlns="jabber:client" from="jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330" to="jaxmpp__m5tirt0563@test-domain.com"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-10-13 23:18:44 | >> <message xmlns="jabber:client" from="test-domain.com" to="jaxmpp__m5tirt0563@test-domain.com"><body>Wecome to 294af1f8-38f5-4b6a-81ec-a707bf5d986d This message was set at: Thu Oct 13 22:53:55 PDT 2022</body><delay stamp="2022-10-14T06:18:44.663Z" xmlns="urn:xmpp:delay" from="test-domain.com">Offline Storage - ed1b7dd8a1b3</delay></message> 2022-10-13 23:18:44 | jaxmpp_ :: jaxmpp__m5tirt0563@test-domain.com/1608752850-tigase-330 << <message xmlns="jabber:client" from="test-domain.com" to="jaxmpp__m5tirt0563@test-domain.com"><body>Wecome to 294af1f8-38f5-4b6a-81ec-a707bf5d986d This message was set at: Thu Oct 13 22:53:55 PDT 2022</body><delay stamp="2022-10-14T06:18:44.663Z" xmlns="urn:xmpp:delay" from="test-domain.com">Offline Storage - ed1b7dd8a1b3</delay></message> 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4099] Connector state changed: disconnecting->disconnected 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-10-13 23:18:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureWebSocket | 0.308s |
2022-10-13 23:18:45 |
2022-10-13 23:18:45 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-10-13 23:18:45 | ------------------------------------ 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-10-13 23:18:45 | >> <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-10-13 23:18:45 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2Q0OW53dzA1NjQscj1sTER3a2ZsMWM1eHBUVWtGaW5aWQ==</auth> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2Q0OW53dzA1NjQscj1sTER3a2ZsMWM1eHBUVWtGaW5aWQ==</auth> 2022-10-13 23:18:45 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sTER3a2ZsMWM1eHBUVWtGaW5aWUdBS0JPMXM3bVdTZlNTdlVFMUl4LHM9R25pOFhuR1pLemU3enc9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sTER3a2ZsMWM1eHBUVWtGaW5aWUdBS0JPMXM3bVdTZlNTdlVFMUl4LHM9R25pOFhuR1pLemU3enc9PSxpPTQwOTY=</challenge> 2022-10-13 23:18:45 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bExEd2tmbDFjNXhwVFVrRmluWllHQUtCTzFzN21XU2ZTU3ZVRTFJeCxwPXBsbUgxS3krTXdhNlBMQW1oUFppTjFkYjN1SzBWZkR6VWFVRmxNY1FrUk09</response> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bExEd2tmbDFjNXhwVFVrRmluWllHQUtCTzFzN21XU2ZTU3ZVRTFJeCxwPXBsbUgxS3krTXdhNlBMQW1oUFppTjFkYjN1SzBWZkR6VWFVRmxNY1FrUk09</response> 2022-10-13 23:18:45 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04SG5mM3ZHUExSUWU5YTI0b2JTdXo2OVlTNzlpcEdPNmF2VnRXUkFNeStnPQ==</success> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04SG5mM3ZHUExSUWU5YTI0b2JTdXo2OVlTNzlpcEdPNmF2VnRXUkFNeStnPQ==</success> 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-10-13 23:18:45 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="ujZF7fLWJCI+sxxPMvHZO7+R0uQ=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-10-13 23:18:45 | << <iq xmlns="jabber:client" id="Ki6U17viNHodOGtbp4fMSR7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com >> <iq xmlns="jabber:client" id="Ki6U17viNHodOGtbp4fMSR7" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-10-13 23:18:45 | >> <iq id="Ki6U17viNHodOGtbp4fMSR7" type="result" xmlns="jabber:client" to="jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331</jid></bind></iq> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com << <iq id="Ki6U17viNHodOGtbp4fMSR7" type="result" xmlns="jabber:client" to="jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331</jid></bind></iq> 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-10-13 23:18:45 | << <iq xmlns="jabber:client" id="0BZm7hRNY4k2fPINCFx9zq3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 >> <iq xmlns="jabber:client" id="0BZm7hRNY4k2fPINCFx9zq3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-10-13 23:18:45 | >> <iq id="0BZm7hRNY4k2fPINCFx9zq3" type="result" xmlns="jabber:client" to="jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331"/> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 << <iq id="0BZm7hRNY4k2fPINCFx9zq3" type="result" xmlns="jabber:client" to="jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331"/> 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-10-13 23:18:45 | << <iq to="test-domain.com" id="5nhdyiY7zcLyxhDxmVXUfSO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 >> <iq to="test-domain.com" id="5nhdyiY7zcLyxhDxmVXUfSO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-10-13 23:18:45 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-10-13 23:18:45 | << <iq id="9HdS5ePGNNFBubtWj04fJvg" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 >> <iq id="9HdS5ePGNNFBubtWj04fJvg" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-10-13 23:18:45 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:45 | jaxmpp_ :: jaxmpp__d49nww0564@test-domain.com/1608752850-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-10-13 23:18:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-10-13 23:18:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-10-13 23:18:48 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |