Generated by TestNG with ReportNG at 22:48 PDT on Wednesday 13 April 2022
root@1bc69cf4cb94 / Java 17.0.2 (Private Build) / Linux 4.14.186-146.268.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 64.134s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.482s
2022-04-13 23:16:41 |

2022-04-13 23:16:41 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:16:41 | ------------------------------------

2022-04-13 23:16:41 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:16:41 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:16:41 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-04-13 23:16:42 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:16:42 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:01 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-04-13 23:17:01 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:01 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:01 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-04-13 23:17:02 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:02 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3UwczEzcTA1NTYscj1aYlY4R2J6ZURkUFBxd0N0eTdJeA==</auth>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3UwczEzcTA1NTYscj1aYlY4R2J6ZURkUFBxd0N0eTdJeA==</auth>

2022-04-13 23:17:02 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aYlY4R2J6ZURkUFBxd0N0eTdJeE9LZlQ4ZW90ZXV5aTB3SUNQNnpkLHM9Mm03cCtVMkp3M1hpeGc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aYlY4R2J6ZURkUFBxd0N0eTdJeE9LZlQ4ZW90ZXV5aTB3SUNQNnpkLHM9Mm03cCtVMkp3M1hpeGc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:02 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WmJWOEdiemVEZFBQcXdDdHk3SXhPS2ZUOGVvdGV1eWkwd0lDUDZ6ZCxwPTc4V2M5N2RRTHhNaDdyTFFOTFhCL3lSbHhXcnNTR1lib1hFdUp5UWh0R2c9</response>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WmJWOEdiemVEZFBQcXdDdHk3SXhPS2ZUOGVvdGV1eWkwd0lDUDZ6ZCxwPTc4V2M5N2RRTHhNaDdyTFFOTFhCL3lSbHhXcnNTR1lib1hFdUp5UWh0R2c9</response>

2022-04-13 23:17:02 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SWFBEYWFraEEvaDNsdVFXc0xLNHZjeXh0amlYb2R6bUN5eTVocmZ2TDNZPQ==</success>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SWFBEYWFraEEvaDNsdVFXc0xLNHZjeXh0amlYb2R6bUN5eTVocmZ2TDNZPQ==</success>

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17: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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:02 |  << <iq xmlns="jabber:client" id="3fnvoQPV0taFJXeu8LMOMKw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com >> <iq xmlns="jabber:client" id="3fnvoQPV0taFJXeu8LMOMKw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17: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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17: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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:02 |  << <iq xmlns="jabber:client" id="Kyg9kO7ueCqSYXWVT6dxsW6" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com >> <iq xmlns="jabber:client" id="Kyg9kO7ueCqSYXWVT6dxsW6" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 |  << <iq xmlns="jabber:client" id="r7VcIrZmKIDIOGvhIT0l5FE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com >> <iq xmlns="jabber:client" id="r7VcIrZmKIDIOGvhIT0l5FE" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:02 |  >> <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320" id="3fnvoQPV0taFJXeu8LMOMKw" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320</jid></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com << <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320" id="3fnvoQPV0taFJXeu8LMOMKw" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320</jid></bind></iq>

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:02 |  << <iq to="test-domain.com" id="klzBoOQHqTPYX1qSY9KSOLN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320 >> <iq to="test-domain.com" id="klzBoOQHqTPYX1qSY9KSOLN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 |  << <iq id="Aya16lX4BqbL1mKENQW2gyk" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320 >> <iq id="Aya16lX4BqbL1mKENQW2gyk" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 |  >> <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321" id="Kyg9kO7ueCqSYXWVT6dxsW6" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321</jid></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-320 << <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321" id="Kyg9kO7ueCqSYXWVT6dxsW6" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321</jid></bind></iq>

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:02 |  << <iq to="test-domain.com" id="9hjo0l5FEkO7ueCqSYXWVT6" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321 >> <iq to="test-domain.com" id="9hjo0l5FEkO7ueCqSYXWVT6" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 |  >> <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322" id="r7VcIrZmKIDIOGvhIT0l5FE" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322</jid></bind></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321 << <iq to="jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322" id="r7VcIrZmKIDIOGvhIT0l5FE" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322</jid></bind></iq>

2022-04-13 23:17:02 |  << <iq id="UmwmKx7y7l4ayj4w6lX4Bqb" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-321 >> <iq id="UmwmKx7y7l4ayj4w6lX4Bqb" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:02 |  << <iq to="test-domain.com" id="LtPZ8LMOMKwgx6fxoNHMAoZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322 >> <iq to="test-domain.com" id="LtPZ8LMOMKwgx6fxoNHMAoZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:02 |  << <iq id="9kmucJRdKwcT2kOOEw38jFE" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322 >> <iq id="9kmucJRdKwcT2kOOEw38jFE" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:02 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__u0s13q0556@test-domain.com/2124985174-tigase-322 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

testStateAfterAuthTimeoutSocket 20.229s
2022-04-13 23:17:02 |

2022-04-13 23:17:02 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:17:02 | ------------------------------------

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Connector  state changed: null->connecting

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] DNS entry stored in session object: localhost:5222

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Preparing connection to [localhost:5222]

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Connector  state changed: connecting->connected

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Whitespace ping period is setted to nullms

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

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

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4039] Start TLS

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4041] Proceeding TLS

2022-04-13 23:17:02 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4041] Start handshake

2022-04-13 23:17:02 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:02 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:02 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4041] Connector  state changed: connected->disconnected

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4041] Stream terminated

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector  state changed: null->connecting

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] DNS entry stored in session object: localhost:5222

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Preparing connection to [localhost:5222]

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector  state changed: connecting->connected

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Whitespace ping period is setted to nullms

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4039] Start TLS

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

2022-04-13 23:17:22 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4046] Proceeding TLS

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4046] Start handshake

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:22 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:22 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzQ1aDRmdzA1NTcscj00WjNCUTZabTdxMXlVYzBPU3ZMMQ==</auth>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzQ1aDRmdzA1NTcscj00WjNCUTZabTdxMXlVYzBPU3ZMMQ==</auth>

2022-04-13 23:17:22 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00WjNCUTZabTdxMXlVYzBPU3ZMMXBxUHRWakpFWGdvMVZsUmx5RW9WLHM9Mmx2Yk9mM2laa0YwdHc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00WjNCUTZabTdxMXlVYzBPU3ZMMXBxUHRWakpFWGdvMVZsUmx5RW9WLHM9Mmx2Yk9mM2laa0YwdHc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:22 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFozQlE2Wm03cTF5VWMwT1N2TDFwcVB0VmpKRVhnbzFWbFJseUVvVixwPXloMnd6NlRTRFlwYUNFU3FhU3VpL0J2dExCeVR3YTlHZDg2TkpMU0ZLZ2c9</response>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFozQlE2Wm03cTF5VWMwT1N2TDFwcVB0VmpKRVhnbzFWbFJseUVvVixwPXloMnd6NlRTRFlwYUNFU3FhU3VpL0J2dExCeVR3YTlHZDg2TkpMU0ZLZ2c9</response>

2022-04-13 23:17:22 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zekJhNXE5M0lydDBQTC9qNkdtcGxtNjBFcStOUVhUV25RZUpXYXdUR09ZPQ==</success>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zekJhNXE5M0lydDBQTC9qNkdtcGxtNjBFcStOUVhUV25RZUpXYXdUR09ZPQ==</success>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:22 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="xg2BpgUST3gZcJRdKwcT2kO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <iq xmlns="jabber:client" id="xg2BpgUST3gZcJRdKwcT2kO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="Yi6PFrgykRaIu7vaNOXj7y8" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com >> <iq xmlns="jabber:client" id="Yi6PFrgykRaIu7vaNOXj7y8" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323" id="xg2BpgUST3gZcJRdKwcT2kO" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323</jid></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323" id="xg2BpgUST3gZcJRdKwcT2kO" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323</jid></bind></iq>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="iLtvgGy8uZ039CfBAcCrk28" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323 >> <iq xmlns="jabber:client" id="iLtvgGy8uZ039CfBAcCrk28" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="Yi6PFrgykRaIu7vaNOXj7y8" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324</jid></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="Yi6PFrgykRaIu7vaNOXj7y8" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324</jid></bind></iq>

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="OMuxkOOEw38jFEjJQIEvsiE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-323 >> <iq xmlns="jabber:client" id="OMuxkOOEw38jFEjJQIEvsiE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="nk6JtYZ1mJzw4mViY09zi3k" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324 >> <iq xmlns="jabber:client" id="nk6JtYZ1mJzw4mViY09zi3k" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="iLtvgGy8uZ039CfBAcCrk28" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325</jid></bind></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="iLtvgGy8uZ039CfBAcCrk28" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325</jid></bind></iq>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:22 |  << <iq xmlns="jabber:client" id="FtvMMTbR26mdGCoYYalItZi" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq xmlns="jabber:client" id="FtvMMTbR26mdGCoYYalItZi" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="OMuxkOOEw38jFEjJQIEvsiE" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="OMuxkOOEw38jFEjJQIEvsiE" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:22 |  << <iq to="test-domain.com" id="byI4xzsW2zo2eEkSLy9l019" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq to="test-domain.com" id="byI4xzsW2zo2eEkSLy9l019" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="nk6JtYZ1mJzw4mViY09zi3k" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-324" id="nk6JtYZ1mJzw4mViY09zi3k" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 |  << <iq id="eQyJu8LMOMKwgx6fxoNHMAo" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq id="eQyJu8LMOMKwgx6fxoNHMAo" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="FtvMMTbR26mdGCoYYalItZi" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="FtvMMTbR26mdGCoYYalItZi" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:22 |  >> <enabled max="60" id="b832dfc8-7abc-4439-90dc-e3d05d506ada" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <enabled max="60" id="b832dfc8-7abc-4439-90dc-e3d05d506ada" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:22 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 |  << <iq to="test-domain.com" id="ToaRJu15uZ5y8ubO04hPO5o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq to="test-domain.com" id="ToaRJu15uZ5y8ubO04hPO5o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 |  << <iq to="test-domain.com" id="cI6UjWUYr8wcAcCfw5dKv7C" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq to="test-domain.com" id="cI6UjWUYr8wcAcCfw5dKv7C" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" from="test-domain.com" id="byI4xzsW2zo2eEkSLy9l019" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" from="test-domain.com" id="byI4xzsW2zo2eEkSLy9l019" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-04-13 23:17:22 |  << <iq id="vvrzayj4w6lX4BqbL1mKENQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq id="vvrzayj4w6lX4BqbL1mKENQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="eQyJu8LMOMKwgx6fxoNHMAo" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="eQyJu8LMOMKwgx6fxoNHMAo" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 |  << <iq id="mBHJGnMBfODn8iOP6AeBt6F" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <iq id="mBHJGnMBfODn8iOP6AeBt6F" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:22 |  >> <presence to="jaxmpp__45h4fw0557@test-domain.com" from="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" xmlns="jabber:client"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <presence to="jaxmpp__45h4fw0557@test-domain.com" from="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" xmlns="jabber:client"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector  state changed: connected->disconnecting

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Terminating XMPP Stream

2022-04-13 23:17:22 |  >> <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="vvrzayj4w6lX4BqbL1mKENQ" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | jaxmpp_ :: jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325 << <iq to="jaxmpp__45h4fw0557@test-domain.com/2124985174-tigase-325" id="vvrzayj4w6lX4BqbL1mKENQ" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4046] Connector  state changed: disconnecting->disconnected

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4046] Stream terminated

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:22 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:22 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterAuthTimeoutWebSocket 20.359s
2022-04-13 23:17:23 |

2022-04-13 23:17:23 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:17:23 | ------------------------------------

2022-04-13 23:17:23 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-04-13 23:17:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-04-13 23:17:23 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-04-13 23:17:23 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-04-13 23:17:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:23 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:23 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:43 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:43 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Zyd3d0eDA1NTgscj1VTHpNZVdnTXJ4SXJ0cGthMmJjYw==</auth>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Zyd3d0eDA1NTgscj1VTHpNZVdnTXJ4SXJ0cGthMmJjYw==</auth>

2022-04-13 23:17:43 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VTHpNZVdnTXJ4SXJ0cGthMmJjY0RkNFRyS1lRakNmaEszSTJNTmY0LHM9Z0U0LzBCNmk2Wm5QOXc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VTHpNZVdnTXJ4SXJ0cGthMmJjY0RkNFRyS1lRakNmaEszSTJNTmY0LHM9Z0U0LzBCNmk2Wm5QOXc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:43 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUx6TWVXZ01yeElydHBrYTJiY2NEZDRUcktZUWpDZmhLM0kyTU5mNCxwPVcrekpXY1g3NWpIVUZmOVRuazk5cDlrbEFHMmpEVnVKM2xSbkNmQVEvcHc9</response>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VUx6TWVXZ01yeElydHBrYTJiY2NEZDRUcktZUWpDZmhLM0kyTU5mNCxwPVcrekpXY1g3NWpIVUZmOVRuazk5cDlrbEFHMmpEVnVKM2xSbkNmQVEvcHc9</response>

2022-04-13 23:17:43 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj15d3NYbGtyeEpvZVFuSm5leG8wM3VPR1RFMXpQVWVzYWo4clJPMnBhRjQwPQ==</success>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj15d3NYbGtyeEpvZVFuSm5leG8wM3VPR1RFMXpQVWVzYWo4clJPMnBhRjQwPQ==</success>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:43 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:43 |  >> <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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="Tvh5boPHIrZmKIDIOGvhIT0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com >> <iq xmlns="jabber:client" id="Tvh5boPHIrZmKIDIOGvhIT0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="rxl2oNHMAoZqewbDqjQ1rn4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com >> <iq xmlns="jabber:client" id="rxl2oNHMAoZqewbDqjQ1rn4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="DEESUhMTbR26mdGCoYYalIt" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com >> <iq xmlns="jabber:client" id="DEESUhMTbR26mdGCoYYalIt" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-326" id="Tvh5boPHIrZmKIDIOGvhIT0" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-326</jid></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-326" id="Tvh5boPHIrZmKIDIOGvhIT0" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-326</jid></bind></iq>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-327" id="rxl2oNHMAoZqewbDqjQ1rn4" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-327</jid></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-327" id="rxl2oNHMAoZqewbDqjQ1rn4" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-327</jid></bind></iq>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="DEESUhMTbR26mdGCoYYalIt" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328</jid></bind></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="DEESUhMTbR26mdGCoYYalIt" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328</jid></bind></iq>

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="DFFUYp2pdVamSfKKEu0etYZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq xmlns="jabber:client" id="DFFUYp2pdVamSfKKEu0etYZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="CBrkV0taFJXeu8LMOMKwgx6" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq xmlns="jabber:client" id="CBrkV0taFJXeu8LMOMKwgx6" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 |  << <iq xmlns="jabber:client" id="7HHY6Fyrh3qSUjS0aw4mJu1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq xmlns="jabber:client" id="7HHY6Fyrh3qSUjS0aw4mJu1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="DFFUYp2pdVamSfKKEu0etYZ" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:43 |  << <iq to="test-domain.com" id="kP3zkGAboPHIrZmKIDIOGvh" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq to="test-domain.com" id="kP3zkGAboPHIrZmKIDIOGvh" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 |  << <iq id="mMS5oNChBw3dOEwfWgAjTWl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq id="mMS5oNChBw3dOEwfWgAjTWl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="DFFUYp2pdVamSfKKEu0etYZ" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:43 |  << <iq to="test-domain.com" id="bPZCDLQIAFAq0cq49kHrcpV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq to="test-domain.com" id="bPZCDLQIAFAq0cq49kHrcpV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 |  << <iq id="G5JZj1xoOM3mY6oOQHqTPYX" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq id="G5JZj1xoOM3mY6oOQHqTPYX" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="CBrkV0taFJXeu8LMOMKwgx6" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="CBrkV0taFJXeu8LMOMKwgx6" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:43 |  << <iq to="test-domain.com" id="gFrlbCu8sW6dsXXet3u0eFM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq to="test-domain.com" id="gFrlbCu8sW6dsXXet3u0eFM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:43 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:43 |  << <iq id="fYkZ8LMOMKwgx6fxoNHMAoZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <iq id="fYkZ8LMOMKwgx6fxoNHMAoZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:43 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:43 |  >> <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="7HHY6Fyrh3qSUjS0aw4mJu1" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 << <iq to="jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328" id="7HHY6Fyrh3qSUjS0aw4mJu1" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:43 |  >> <enabled max="60" id="6826a79f-1205-431e-8503-aa68dc5fe92f" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__vrwwtx0558@test-domain.com/2124985174-tigase-328 << <enabled max="60" id="6826a79f-1205-431e-8503-aa68dc5fe92f" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

testStateAfterConnectionFailureBosh 0.715s
2022-04-13 23:17:43 |

2022-04-13 23:17:43 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:17:43 | ------------------------------------

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:43 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-04-13 23:17:43 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:43 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:43 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2QxdWQxYzA1NTkscj1GRzA3d2RzejNBSHAxckFycHprZg==</auth>

2022-04-13 23:17:43 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2QxdWQxYzA1NTkscj1GRzA3d2RzejNBSHAxckFycHprZg==</auth>

2022-04-13 23:17:44 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GRzA3d2RzejNBSHAxckFycHprZm1CQmNReTFxcEx4QXZ2c2U0b2tFLHM9TDNvUEl5ZW1uaEp3Vmc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GRzA3d2RzejNBSHAxckFycHprZm1CQmNReTFxcEx4QXZ2c2U0b2tFLHM9TDNvUEl5ZW1uaEp3Vmc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:44 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkcwN3dkc3ozQUhwMXJBcnB6a2ZtQkJjUXkxcXBMeEF2dnNlNG9rRSxwPW5ZVnZobXlFaWlraEI5MEZxYkNxRExhWGdweTVQWEUrTlhLU0FucGlvN2c9</response>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkcwN3dkc3ozQUhwMXJBcnB6a2ZtQkJjUXkxcXBMeEF2dnNlNG9rRSxwPW5ZVnZobXlFaWlraEI5MEZxYkNxRExhWGdweTVQWEUrTlhLU0FucGlvN2c9</response>

2022-04-13 23:17:44 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1nSzN3a3VJSnRoSXFFZTVqK2pERzJ3TEQraVNMdVlEOW00VHFxK3lyM0EwPQ==</success>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1nSzN3a3VJSnRoSXFFZTVqK2pERzJ3TEQraVNMdVlEOW00VHFxK3lyM0EwPQ==</success>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:44 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:44 |  << <iq xmlns="jabber:client" id="TKwz9kHrcpVeucBEGqZfELK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com >> <iq xmlns="jabber:client" id="TKwz9kHrcpVeucBEGqZfELK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:44 |  >> <iq to="jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329" id="TKwz9kHrcpVeucBEGqZfELK" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329</jid></bind></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com << <iq to="jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329" id="TKwz9kHrcpVeucBEGqZfELK" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329</jid></bind></iq>

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:44 |  << <iq to="test-domain.com" id="80gZr6xtrcq0vgMICgKv27h" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329 >> <iq to="test-domain.com" id="80gZr6xtrcq0vgMICgKv27h" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:44 |  << <iq id="t4qargykRaIu7vaNOXj7y8q" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329 >> <iq id="t4qargykRaIu7vaNOXj7y8q" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__d1ud1c0559@test-domain.com/2124985174-tigase-329 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

testStateAfterConnectionFailureSocket 0.187s
2022-04-13 23:17:44 |

2022-04-13 23:17:44 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:17:44 | ------------------------------------

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector  state changed: null->connecting

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] DNS entry stored in session object: missing:5222

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Preparing connection to [missing:5222]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] missing. Trying next.

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector  state changed: connecting->disconnected

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector  state changed: null->connecting

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] DNS entry stored in session object: localhost:5222

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Preparing connection to [localhost:5222]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector  state changed: connecting->connected

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Whitespace ping period is setted to nullms

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

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

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4099] Start TLS

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4103] Proceeding TLS

2022-04-13 23:17:44 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4103] Start handshake

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:44 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:44 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3dieGswcTA1NjAscj1HckxQQkt5STFTbEZrUzBqVTZqQg==</auth>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3dieGswcTA1NjAscj1HckxQQkt5STFTbEZrUzBqVTZqQg==</auth>

2022-04-13 23:17:44 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HckxQQkt5STFTbEZrUzBqVTZqQjRHRklSbTFMOHNsUTExQ0dZRmt6LHM9d1ZzK1NJbC8yZDIzbmc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HckxQQkt5STFTbEZrUzBqVTZqQjRHRklSbTFMOHNsUTExQ0dZRmt6LHM9d1ZzK1NJbC8yZDIzbmc9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:44 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3JMUEJLeUkxU2xGa1MwalU2akI0R0ZJUm0xTDhzbFExMUNHWUZreixwPW92UmhOU1hsVEd5b2dRQ1NPdG51ZVBhazV3RFUxYzAyQ3E3NzgrdDFuNkU9</response>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3JMUEJLeUkxU2xGa1MwalU2akI0R0ZJUm0xTDhzbFExMUNHWUZreixwPW92UmhOU1hsVEd5b2dRQ1NPdG51ZVBhazV3RFUxYzAyQ3E3NzgrdDFuNkU9</response>

2022-04-13 23:17:44 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1JbzRHdENJZ3A5Ym9TRmp5MWxQa3c3amtNak5rTkNXS2NsWWROa2NNSXhBPQ==</success>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1JbzRHdENJZ3A5Ym9TRmp5MWxQa3c3amtNak5rTkNXS2NsWWROa2NNSXhBPQ==</success>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:44 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:44 |  << <iq xmlns="jabber:client" id="E5l9LKP3Bw4i5q6mUQUPGpR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com >> <iq xmlns="jabber:client" id="E5l9LKP3Bw4i5q6mUQUPGpR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:44 |  >> <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="E5l9LKP3Bw4i5q6mUQUPGpR" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330</jid></bind></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com << <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="E5l9LKP3Bw4i5q6mUQUPGpR" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330</jid></bind></iq>

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:44 |  << <iq xmlns="jabber:client" id="9Z1OQ1rn4autcEs6eGnMBfO" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 >> <iq xmlns="jabber:client" id="9Z1OQ1rn4autcEs6eGnMBfO" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:44 |  >> <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="9Z1OQ1rn4autcEs6eGnMBfO" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 << <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="9Z1OQ1rn4autcEs6eGnMBfO" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:44 |  << <iq to="test-domain.com" id="0eILKHQ4cxlQ9wn9NUQQbCu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 >> <iq to="test-domain.com" id="0eILKHQ4cxlQ9wn9NUQQbCu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:44 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:44 |  >> <enabled max="60" id="308b23cb-0603-4f0c-9cf0-7f402cd1b342" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 << <enabled max="60" id="308b23cb-0603-4f0c-9cf0-7f402cd1b342" xmlns="urn:xmpp:sm:3" location="1bc69cf4cb94" resume="true"/>

2022-04-13 23:17:44 |  << <iq id="5fJPNRSdEDFPYY6HEygIs8h" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 >> <iq id="5fJPNRSdEDFPYY6HEygIs8h" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 |  >> <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" from="test-domain.com" id="0eILKHQ4cxlQ9wn9NUQQbCu" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 << <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" from="test-domain.com" id="0eILKHQ4cxlQ9wn9NUQQbCu" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="component" type="router"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b11711/807ecad4" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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: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:priority:0"/><feature var="tigase:push:filter:muted: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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-04-13 23:17:44 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-04-13 23:17:44 |  >> <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="5fJPNRSdEDFPYY6HEygIs8h" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 << <iq to="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" id="5fJPNRSdEDFPYY6HEygIs8h" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector  state changed: connected->disconnecting

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Terminating XMPP Stream

2022-04-13 23:17:44 |  >> <presence to="jaxmpp__wbxk0q0560@test-domain.com" from="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" xmlns="jabber:client"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-04-13 23:17:44 | jaxmpp_ :: jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330 << <presence to="jaxmpp__wbxk0q0560@test-domain.com" from="jaxmpp__wbxk0q0560@test-domain.com/2124985174-tigase-330" xmlns="jabber:client"><c hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence>

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4103] Connector  state changed: disconnecting->disconnected

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4103] Stream terminated

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureWebSocket 0.327s
2022-04-13 23:17:44 |

2022-04-13 23:17:44 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-04-13 23:17:44 | ------------------------------------

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-04-13 23:17:44 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected

2022-04-13 23:17:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:45 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><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><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-04-13 23:17:45 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2swbWt0NDA1NjEscj1zYjdFUndqOWRPRXFkV05VUlR3dA==</auth>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2swbWt0NDA1NjEscj1zYjdFUndqOWRPRXFkV05VUlR3dA==</auth>

2022-04-13 23:17:45 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zYjdFUndqOWRPRXFkV05VUlR3dHNpa1QybHIwb2ttY3JNZ2l5eWZmLHM9cE5acG5yOGxBOEdvd0E9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zYjdFUndqOWRPRXFkV05VUlR3dHNpa1QybHIwb2ttY3JNZ2l5eWZmLHM9cE5acG5yOGxBOEdvd0E9PSxpPTQwOTY=</challenge>

2022-04-13 23:17:45 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2I3RVJ3ajlkT0VxZFdOVVJUd3RzaWtUMmxyMG9rbWNyTWdpeXlmZixwPS9sUFRtdTNiVFVIVVRIK3cxaVhZcnAyZHBaWE5XQkZnVkZmVHNqTkNKeU09</response>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2I3RVJ3ajlkT0VxZFdOVVJUd3RzaWtUMmxyMG9rbWNyTWdpeXlmZixwPS9sUFRtdTNiVFVIVVRIK3cxaVhZcnAyZHBaWE5XQkZnVkZmVHNqTkNKeU09</response>

2022-04-13 23:17:45 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zQ2FGdENra0dWSjNLUzNwcmVyMklNbXFsdDArS1ZLejhzUGdBNS9JUjZjPQ==</success>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zQ2FGdENra0dWSjNLUzNwcmVyMklNbXFsdDArS1ZLejhzUGdBNS9JUjZjPQ==</success>

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-04-13 23:17:45 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="OzXuhCJ7IWWQ9VEkBfuf7IUIH/c=" xmlns="http://jabber.org/protocol/caps"/></features>

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-04-13 23:17:45 |  << <iq xmlns="jabber:client" id="xXJZbO04hPO5o7DLQIAFAq0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com >> <iq xmlns="jabber:client" id="xXJZbO04hPO5o7DLQIAFAq0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-04-13 23:17:45 |  >> <iq to="jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331" id="xXJZbO04hPO5o7DLQIAFAq0" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331</jid></bind></iq>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com << <iq to="jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331" id="xXJZbO04hPO5o7DLQIAFAq0" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331</jid></bind></iq>

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-04-13 23:17:45 |  << <iq xmlns="jabber:client" id="R68LykFmLzsVXiCs7GKyfLG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331 >> <iq xmlns="jabber:client" id="R68LykFmLzsVXiCs7GKyfLG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-04-13 23:17:45 |  >> <iq to="jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331" id="R68LykFmLzsVXiCs7GKyfLG" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331 << <iq to="jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331" id="R68LykFmLzsVXiCs7GKyfLG" xmlns="jabber:client" type="result"/>

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-04-13 23:17:45 |  << <iq to="test-domain.com" id="1ZL3j4w6lX4BqbL1mKENQW2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331 >> <iq to="test-domain.com" id="1ZL3j4w6lX4BqbL1mKENQW2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-04-13 23:17:45 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-04-13 23:17:45 |  << <iq id="KtbZ0aPU4iMAoNChBw3dOEw" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:45 | jaxmpp_ :: jaxmpp__k0mkt40561@test-domain.com/2124985174-tigase-331 >> <iq id="KtbZ0aPU4iMAoNChBw3dOEw" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-04-13 23:17:45 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-04-13 23:17:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-04-13 23:17:48 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted