Generated by TestNG with ReportNG at 22:21 PDT on Monday 10 October 2022
root@f9c07ffec79b / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 102.854s

Failed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 40.116s
2022-10-10 22:44:20 |

2022-10-10 22:44:20 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:44:20 | ------------------------------------

2022-10-10 22:44:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:44:20 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:44:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-10-10 22:44:40 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-10-10 22:44:40 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:44:40 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:44:40 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-10-10 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

java.lang.AssertionError: expected [true] but found [false]
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.118s
2022-10-10 22:45:41 |

2022-10-10 22:45:41 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:45:41 | ------------------------------------

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

java.lang.AssertionError: expected [true] but found [false]
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.262s
2022-10-10 22:45:00 |

2022-10-10 22:45:00 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:45:00 | ------------------------------------

2022-10-10 22:45:00 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: null->connecting

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222]

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: connecting->connected

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms

2022-10-10 22:45:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:00 |  >> <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-10 22:45:00 | jaxmpp_ :: jaxmpp__qgho600560@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-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4052] Start TLS

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4054] Proceeding TLS

2022-10-10 22:45:00 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4054] Start handshake

2022-10-10 22:45:00 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:45:00 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:45:00 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:00 |  >> <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-10 22:45:00 | jaxmpp_ :: jaxmpp__qgho600560@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-10 22:45:00 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4054] Connector  state changed: connected->disconnected

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4054] Stream terminated

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: null->connecting

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: localhost:5222

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222]

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connecting->connected

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:20 |  >> <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-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@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-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4052] Start TLS

2022-10-10 22:45:20 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4059] Proceeding TLS

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4059] Start handshake

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:20 |  >> <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-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@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-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-10-10 22:45:20 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FnaG82MDA1NjAscj1Sa21BRVJwQ256VmY2WUpGdWhMbg==</auth>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FnaG82MDA1NjAscj1Sa21BRVJwQ256VmY2WUpGdWhMbg==</auth>

2022-10-10 22:45:20 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Sa21BRVJwQ256VmY2WUpGdWhMbkphN0dBUFRSRjRVR3NtMDRxaDBFLHM9S3U1VC9wVHIySDgrWWc9PSxpPTQwOTY=</challenge>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Sa21BRVJwQ256VmY2WUpGdWhMbkphN0dBUFRSRjRVR3NtMDRxaDBFLHM9S3U1VC9wVHIySDgrWWc9PSxpPTQwOTY=</challenge>

2022-10-10 22:45:20 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmttQUVScENuelZmNllKRnVoTG5KYTdHQVBUUkY0VUdzbTA0cWgwRSxwPVZaZ1ZCWk5QUTQ4dnpaTm85ekRsUFUzK2RnK3RHS0ZONTJIVWN6UWhKaE09</response>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UmttQUVScENuelZmNllKRnVoTG5KYTdHQVBUUkY0VUdzbTA0cWgwRSxwPVZaZ1ZCWk5QUTQ4dnpaTm85ekRsUFUzK2RnK3RHS0ZONTJIVWN6UWhKaE09</response>

2022-10-10 22:45:20 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04d0Z2ZFB1cFludWVpQ3hncGxNTVZ6dEU2cEp0c3JyY3lVU21hQWdZdThZPQ==</success>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj04d0Z2ZFB1cFludWVpQ3hncGxNTVZ6dEU2cEp0c3JyY3lVU21hQWdZdThZPQ==</success>

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:20 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="u3CDxdQTQ9m25xjFIO1v0kI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <iq xmlns="jabber:client" id="u3CDxdQTQ9m25xjFIO1v0kI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="AIzTQ01p39GKTfuiEJtmOFH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <iq xmlns="jabber:client" id="AIzTQ01p39GKTfuiEJtmOFH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-324" id="u3CDxdQTQ9m25xjFIO1v0kI" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-324</jid></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-324" id="u3CDxdQTQ9m25xjFIO1v0kI" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-324</jid></bind></iq>

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="gFooQ7fUUR5sakHws1jLW5e" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com >> <iq xmlns="jabber:client" id="gFooQ7fUUR5sakHws1jLW5e" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325" id="AIzTQ01p39GKTfuiEJtmOFH" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325</jid></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325" id="AIzTQ01p39GKTfuiEJtmOFH" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325</jid></bind></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="h0n6DhY27BuesX2u5r1s7i3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325 >> <iq xmlns="jabber:client" id="h0n6DhY27BuesX2u5r1s7i3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="gFooQ7fUUR5sakHws1jLW5e" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326</jid></bind></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="gFooQ7fUUR5sakHws1jLW5e" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326</jid></bind></iq>

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="GW9DEGLZYgABdQMBzq6cr0q" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325 >> <iq xmlns="jabber:client" id="GW9DEGLZYgABdQMBzq6cr0q" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325" id="h0n6DhY27BuesX2u5r1s7i3" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-325" id="h0n6DhY27BuesX2u5r1s7i3" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 |  << <iq xmlns="jabber:client" id="qYdIt4ydHxubqjGGn7tZm6B" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq xmlns="jabber:client" id="qYdIt4ydHxubqjGGn7tZm6B" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:45:20 |  << <iq to="test-domain.com" id="nMBR0gw5i07v9IDk7iUP1hB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="nMBR0gw5i07v9IDk7iUP1hB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="GW9DEGLZYgABdQMBzq6cr0q" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="GW9DEGLZYgABdQMBzq6cr0q" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:20 |  >> <enabled location="f9c07ffec79b" max="60" id="106bc66d-8098-4b2f-a6a9-02fb2c74d193" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <enabled location="f9c07ffec79b" max="60" id="106bc66d-8098-4b2f-a6a9-02fb2c74d193" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:20 |  << <iq id="GZcJQ4xx4sYnLWYZlYcoPMY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq id="GZcJQ4xx4sYnLWYZlYcoPMY" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="qYdIt4ydHxubqjGGn7tZm6B" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="qYdIt4ydHxubqjGGn7tZm6B" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:20 |  << <iq to="test-domain.com" id="lbKSNXcEiDocvhHOPITQ01p" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="lbKSNXcEiDocvhHOPITQ01p" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="nMBR0gw5i07v9IDk7iUP1hB" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="nMBR0gw5i07v9IDk7iUP1hB" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 |  << <iq id="bPEYk3z8AeTN06fR0gw5i07" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq id="bPEYk3z8AeTN06fR0gw5i07" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="GZcJQ4xx4sYnLWYZlYcoPMY" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="GZcJQ4xx4sYnLWYZlYcoPMY" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 |  << <iq to="test-domain.com" id="TQFZgMy9qgDxdQTQ9m25xjF" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="TQFZgMy9qgDxdQTQ9m25xjF" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:20 |  << <iq id="JcH5DgQKVR8mLT4oMBk4fLF" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <iq id="JcH5DgQKVR8mLT4oMBk4fLF" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="lbKSNXcEiDocvhHOPITQ01p" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="lbKSNXcEiDocvhHOPITQ01p" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="bPEYk3z8AeTN06fR0gw5i07" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="bPEYk3z8AeTN06fR0gw5i07" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connected->disconnecting

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream

2022-10-10 22:45:20 |  >> <presence to="jaxmpp__qgho600560@test-domain.com" xmlns="jabber:client" from="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <presence to="jaxmpp__qgho600560@test-domain.com" xmlns="jabber:client" from="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-10-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="TQFZgMy9qgDxdQTQ9m25xjF" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="TQFZgMy9qgDxdQTQ9m25xjF" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:45:20 |  >> <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="JcH5DgQKVR8mLT4oMBk4fLF" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | jaxmpp_ :: jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__qgho600560@test-domain.com/1781077109-tigase-326" id="JcH5DgQKVR8mLT4oMBk4fLF" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4059] Connector  state changed: disconnecting->disconnected

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4059] Stream terminated

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-10-10 22:45:20 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:20 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterAuthTimeoutWebSocket 20.351s
2022-10-10 22:45:21 |

2022-10-10 22:45:21 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:45:21 | ------------------------------------

2022-10-10 22:45:21 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-10-10 22:45:21 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-10-10 22:45:21 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-10-10 22:45:21 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-10-10 22:45:21 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:21 |  >> <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-10 22:45:21 | jaxmpp_ :: jaxmpp__qq5e9r0561@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-10 22:45:21 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:41 |  >> <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-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@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-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-10-10 22:45:41 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FxNWU5cjA1NjEscj05Y1NGUTVRbXQxZU41bkNseVJnSA==</auth>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FxNWU5cjA1NjEscj05Y1NGUTVRbXQxZU41bkNseVJnSA==</auth>

2022-10-10 22:45:41 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05Y1NGUTVRbXQxZU41bkNseVJnSDVBeXEzQm1qVkdwRERmbFB1TmRaLHM9TGpYdTQxOEdXbUhQUFE9PSxpPTQwOTY=</challenge>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05Y1NGUTVRbXQxZU41bkNseVJnSDVBeXEzQm1qVkdwRERmbFB1TmRaLHM9TGpYdTQxOEdXbUhQUFE9PSxpPTQwOTY=</challenge>

2022-10-10 22:45:41 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OWNTRlE1UW10MWVONW5DbHlSZ0g1QXlxM0JtalZHcEREZmxQdU5kWixwPVJHTWtkeTZzdTdXVisvUUljQzRKOFlxa2MwdHh0ZG9VU3Z3U3hPYkExUms9</response>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OWNTRlE1UW10MWVONW5DbHlSZ0g1QXlxM0JtalZHcEREZmxQdU5kWixwPVJHTWtkeTZzdTdXVisvUUljQzRKOFlxa2MwdHh0ZG9VU3Z3U3hPYkExUms9</response>

2022-10-10 22:45:41 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01SWQ3UE82QUxJWWpvNzhwbHVzM0JRYkFEYThzK2N5TEZnLzczaFFLRDVvPQ==</success>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj01SWQ3UE82QUxJWWpvNzhwbHVzM0JRYkFEYThzK2N5TEZnLzczaFFLRDVvPQ==</success>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:45:41 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="ofI0gw5i07v9IDk7iUP1hBA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com >> <iq xmlns="jabber:client" id="ofI0gw5i07v9IDk7iUP1hBA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="AXOnOWT9x7CCDJsewtXkKxr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com >> <iq xmlns="jabber:client" id="AXOnOWT9x7CCDJsewtXkKxr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="IiNgVjCyaLxu4bJKKu1aKBt" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com >> <iq xmlns="jabber:client" id="IiNgVjCyaLxu4bJKKu1aKBt" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-327" id="ofI0gw5i07v9IDk7iUP1hBA" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-327" id="ofI0gw5i07v9IDk7iUP1hBA" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-328" id="AXOnOWT9x7CCDJsewtXkKxr" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-328</jid></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-328" id="AXOnOWT9x7CCDJsewtXkKxr" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-328</jid></bind></iq>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="IiNgVjCyaLxu4bJKKu1aKBt" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329</jid></bind></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="IiNgVjCyaLxu4bJKKu1aKBt" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329</jid></bind></iq>

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="gVEUSbnaqT9AqQJAAhPN0du" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="gVEUSbnaqT9AqQJAAhPN0du" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="EXI5pR6AzBcIupP4evn2kEl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="EXI5pR6AzBcIupP4evn2kEl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 |  << <iq xmlns="jabber:client" id="167W5eVU8hV5dO0phyqUfvq" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="167W5eVU8hV5dO0phyqUfvq" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="gVEUSbnaqT9AqQJAAhPN0du" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="gVEUSbnaqT9AqQJAAhPN0du" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="EXI5pR6AzBcIupP4evn2kEl" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="EXI5pR6AzBcIupP4evn2kEl" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 |  >> <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="167W5eVU8hV5dO0phyqUfvq" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 << <iq to="jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329" id="167W5eVU8hV5dO0phyqUfvq" xmlns="jabber:client" type="result"/>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:45:41 |  << <iq to="test-domain.com" id="Wetev8GtdzyjGPIKvnZ1qeR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq to="test-domain.com" id="Wetev8GtdzyjGPIKvnZ1qeR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 |  << <iq to="test-domain.com" id="RpYkHLOSKxcOJJBCrWlKODD" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq to="test-domain.com" id="RpYkHLOSKxcOJJBCrWlKODD" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 |  << <iq to="test-domain.com" id="epWDgQKVR8mLT4oMBk4fLFK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq to="test-domain.com" id="epWDgQKVR8mLT4oMBk4fLFK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:45:41 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 |  << <iq id="A5XEm25xjFIO1v0kIRJSQJP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq id="A5XEm25xjFIO1v0kIRJSQJP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 |  << <iq id="9pTiDEGLZYgABdQMBzq6cr0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq id="9pTiDEGLZYgABdQMBzq6cr0" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 |  << <iq id="ut3ufDGzcRMSLT15yundqao" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <iq id="ut3ufDGzcRMSLT15yundqao" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:45:41 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:45:41 |  >> <enabled location="f9c07ffec79b" max="60" id="4aff803d-294b-4a05-9fde-321225518749" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 | jaxmpp_ :: jaxmpp__qq5e9r0561@test-domain.com/1781077109-tigase-329 << <enabled location="f9c07ffec79b" max="60" id="4aff803d-294b-4a05-9fde-321225518749" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-10-10 22:45:41 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-10-10 22:45:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-10-10 22:45:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureSocket 0.194s
2022-10-10 22:46:01 |

2022-10-10 22:46:01 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:46:01 | ------------------------------------

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: null->connecting

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] DNS entry stored in session object: missing:5222

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222]

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing: Name or service not known. Trying next.

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: connecting->disconnected

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: null->connecting

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] DNS entry stored in session object: localhost:5222

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222]

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connecting->connected

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:46:01 |  >> <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-10 22:46:01 | jaxmpp_ :: jaxmpp__m1i14m0563@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-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4102] Start TLS

2022-10-10 22:46:01 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:46:01 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4106] Proceeding TLS

2022-10-10 22:46:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4106] Start handshake

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:46:01 |  >> <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-10 22:46:01 | jaxmpp_ :: jaxmpp__m1i14m0563@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-10 22:46:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-10-10 22:46:01 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-10-10 22:46:01 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX20xaTE0bTA1NjMscj1ud0NJbkJNNnRLdVhkSDVFODA3eQ==</auth>

2022-10-10 22:46:01 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX20xaTE0bTA1NjMscj1ud0NJbkJNNnRLdVhkSDVFODA3eQ==</auth>

2022-10-10 22:46:01 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ud0NJbkJNNnRLdVhkSDVFODA3eTQ2ck1jblkzMVM0MjhSQzEwRE1LLHM9aTVielg5WUtIMUN1M0E9PSxpPTQwOTY=</challenge>

2022-10-10 22:46:01 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ud0NJbkJNNnRLdVhkSDVFODA3eTQ2ck1jblkzMVM0MjhSQzEwRE1LLHM9aTVielg5WUtIMUN1M0E9PSxpPTQwOTY=</challenge>

2022-10-10 22:46:02 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bndDSW5CTTZ0S3VYZEg1RTgwN3k0NnJNY25ZMzFTNDI4UkMxMERNSyxwPVdrODZJbmN3bXcxRXdLNVUzcE1LVjg1ZmE1RVRpZ1JNdWs4NkpIMkhlc0U9</response>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bndDSW5CTTZ0S3VYZEg1RTgwN3k0NnJNY25ZMzFTNDI4UkMxMERNSyxwPVdrODZJbmN3bXcxRXdLNVUzcE1LVjg1ZmE1RVRpZ1JNdWs4NkpIMkhlc0U9</response>

2022-10-10 22:46:02 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1UbFVGOVU2S2F2Y3hJUTdDOU1YUGhPN1BBNE1iMS9LNkdJYmVWRnplVnAwPQ==</success>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1UbFVGOVU2S2F2Y3hJUTdDOU1YUGhPN1BBNE1iMS9LNkdJYmVWRnplVnAwPQ==</success>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:46:02 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:46:02 |  << <iq xmlns="jabber:client" id="yAaOGPIKvnZ1qeRbm28Hpey" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com >> <iq xmlns="jabber:client" id="yAaOGPIKvnZ1qeRbm28Hpey" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="yAaOGPIKvnZ1qeRbm28Hpey" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330</jid></bind></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com << <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="yAaOGPIKvnZ1qeRbm28Hpey" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330</jid></bind></iq>

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:46:02 |  << <iq xmlns="jabber:client" id="ShdKR0gw5i07v9IDk7iUP1h" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 >> <iq xmlns="jabber:client" id="ShdKR0gw5i07v9IDk7iUP1h" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="ShdKR0gw5i07v9IDk7iUP1h" xmlns="jabber:client" type="result"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="ShdKR0gw5i07v9IDk7iUP1h" xmlns="jabber:client" type="result"/>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:46:02 |  << <iq to="test-domain.com" id="McWt0rTcu1p6sURQ6jTVgJw" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="McWt0rTcu1p6sURQ6jTVgJw" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:46:02 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 |  >> <enabled location="f9c07ffec79b" max="60" id="929013ca-2715-4629-918e-cbe733ad84dd" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 << <enabled location="f9c07ffec79b" max="60" id="929013ca-2715-4629-918e-cbe733ad84dd" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 |  << <iq id="5Gm3qR5pR6AzBcIupP4evn2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 >> <iq id="5Gm3qR5pR6AzBcIupP4evn2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="McWt0rTcu1p6sURQ6jTVgJw" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="McWt0rTcu1p6sURQ6jTVgJw" xmlns="jabber:client" from="test-domain.com" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12127/cccf702b" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><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 category="pubsub" type="pep"/><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-10 22:46:02 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="5Gm3qR5pR6AzBcIupP4evn2" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330" id="5Gm3qR5pR6AzBcIupP4evn2" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connected->disconnecting

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream

2022-10-10 22:46:02 |  >> <presence to="jaxmpp__m1i14m0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330 << <presence to="jaxmpp__m1i14m0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__m1i14m0563@test-domain.com/1781077109-tigase-330"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4106] Connector  state changed: disconnecting->disconnected

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4106] Stream terminated

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureWebSocket 0.320s
2022-10-10 22:46:02 |

2022-10-10 22:46:02 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-10-10 22:46:02 | ------------------------------------

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:46:02 |  >> <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-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@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-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-10-10 22:46:02 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzhib2R0MDU2NCxyPXZGYjB4eTZXVm50SlJONklUbHBp</auth>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzhib2R0MDU2NCxyPXZGYjB4eTZXVm50SlJONklUbHBp</auth>

2022-10-10 22:46:02 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12RmIweHk2V1ZudEpSTjZJVGxwaWcyQU1CNWZKTENoaHd0Ykw2aDJOLHM9N1UzcU5sSk1qL3cyR2c9PSxpPTQwOTY=</challenge>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12RmIweHk2V1ZudEpSTjZJVGxwaWcyQU1CNWZKTENoaHd0Ykw2aDJOLHM9N1UzcU5sSk1qL3cyR2c9PSxpPTQwOTY=</challenge>

2022-10-10 22:46:02 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkZiMHh5NldWbnRKUk42SVRscGlnMkFNQjVmSkxDaGh3dGJMNmgyTixwPVhXelMzUlozMlNsMDJsSHhrbGxqdEFLQW1wNFlLNy9rc0YzSHBLcWhCWms9</response>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkZiMHh5NldWbnRKUk42SVRscGlnMkFNQjVmSkxDaGh3dGJMNmgyTixwPVhXelMzUlozMlNsMDJsSHhrbGxqdEFLQW1wNFlLNy9rc0YzSHBLcWhCWms9</response>

2022-10-10 22:46:02 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VUjlkQmxVNTFXdHhpQW1uUjZFVmtObXlZV2V5VnJFTExBTU8zRkR0bDJjPQ==</success>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VUjlkQmxVNTFXdHhpQW1uUjZFVmtObXlZV2V5VnJFTExBTU8zRkR0bDJjPQ==</success>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-10-10 22:46:02 |  >> <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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@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 node="https://tigase.net/tigase-xmpp-server" ver="f+zs4caO5M2tCcM2TP01UuCIlOI=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps"/></features>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-10-10 22:46:02 |  << <iq xmlns="jabber:client" id="yHh28JwmJPTP2sj5aEm9j2a" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com >> <iq xmlns="jabber:client" id="yHh28JwmJPTP2sj5aEm9j2a" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331" id="yHh28JwmJPTP2sj5aEm9j2a" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331</jid></bind></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com << <iq to="jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331" id="yHh28JwmJPTP2sj5aEm9j2a" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331</jid></bind></iq>

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-10-10 22:46:02 |  << <iq xmlns="jabber:client" id="RIiXXhQWSNIQNRR8t0t0kFH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 >> <iq xmlns="jabber:client" id="RIiXXhQWSNIQNRR8t0t0kFH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-10-10 22:46:02 |  >> <iq to="jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331" id="RIiXXhQWSNIQNRR8t0t0kFH" xmlns="jabber:client" type="result"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331" id="RIiXXhQWSNIQNRR8t0t0kFH" xmlns="jabber:client" type="result"/>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-10-10 22:46:02 |  << <iq to="test-domain.com" id="Cnf5bJHrgUdTMSO37EoP1kU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="Cnf5bJHrgUdTMSO37EoP1kU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-10-10 22:46:02 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 |  << <iq id="Mk4JwtXkKxraAanSar9riNE" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 >> <iq id="Mk4JwtXkKxraAanSar9riNE" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-10-10 22:46:02 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-10-10 22:46:02 |  >> <enabled location="f9c07ffec79b" max="60" id="bafa052e-0ded-4bcb-b290-47c6ebddb5d7" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 | jaxmpp_ :: jaxmpp__8bodt0564@test-domain.com/1781077109-tigase-331 << <enabled location="f9c07ffec79b" max="60" id="bafa052e-0ded-4bcb-b290-47c6ebddb5d7" xmlns="urn:xmpp:sm:3" resume="true"/>

2022-10-10 22:46:02 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-10-10 22:46:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-10-10 22:46:05 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted