Generated by TestNG with ReportNG at 22:19 PDT on Sunday 28 August 2022
root@ed1b7dd8a1b3 / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 64.543s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.518s
2022-08-28 22:42:44 |

2022-08-28 22:42:44 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:42:44 | ------------------------------------

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

2022-08-28 22:42:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:42:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-08-28 22:42:44 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:42:44 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:04 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-08-28 22:43:04 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:04 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:04 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-08-28 22:43:04 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:04 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-08-28 22:43:04 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:04 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FkaGl3bDA1NTkscj1aSlhRZTF2dFNObVNTTE1JTXgwMg==</auth>

2022-08-28 22:43:04 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FkaGl3bDA1NTkscj1aSlhRZTF2dFNObVNTTE1JTXgwMg==</auth>

2022-08-28 22:43:05 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aSlhRZTF2dFNObVNTTE1JTXgwMmR5U0IwNEcxUnIybk02eHZBblJYLHM9VVNWVWlDQ0RGQzRsUEE9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aSlhRZTF2dFNObVNTTE1JTXgwMmR5U0IwNEcxUnIybk02eHZBblJYLHM9VVNWVWlDQ0RGQzRsUEE9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:05 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkpYUWUxdnRTTm1TU0xNSU14MDJkeVNCMDRHMVJyMm5NNnh2QW5SWCxwPUVQcW9hNkZuMXhIaVRuZmZvQ2ZILzNBdEJIejVGNGlHUHBFcHZkSzFJSHc9</response>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WkpYUWUxdnRTTm1TU0xNSU14MDJkeVNCMDRHMVJyMm5NNnh2QW5SWCxwPUVQcW9hNkZuMXhIaVRuZmZvQ2ZILzNBdEJIejVGNGlHUHBFcHZkSzFJSHc9</response>

2022-08-28 22:43:05 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1vQ1pxWHY5VDV4TDFaNmljcFJKWWZha1VjSEJ6clg0UjVlZ1NFaGFMUm8wPQ==</success>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1vQ1pxWHY5VDV4TDFaNmljcFJKWWZha1VjSEJ6clg0UjVlZ1NFaGFMUm8wPQ==</success>

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:05 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 |  << <iq xmlns="jabber:client" id="aEvJLM1p6BtX6jT8jTZ1u3a" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com >> <iq xmlns="jabber:client" id="aEvJLM1p6BtX6jT8jTZ1u3a" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 |  << <iq xmlns="jabber:client" id="QNUdHKxlTP6hCGECCeL0t4z" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com >> <iq xmlns="jabber:client" id="QNUdHKxlTP6hCGECCeL0t4z" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:05 |  >> <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325" xmlns="jabber:client" id="aEvJLM1p6BtX6jT8jTZ1u3a"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325</jid></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com << <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325" xmlns="jabber:client" id="aEvJLM1p6BtX6jT8jTZ1u3a"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325</jid></bind></iq>

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:05 |  << <iq xmlns="jabber:client" id="JS7ZlYlXV2bDChPRLY16EAu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325 >> <iq xmlns="jabber:client" id="JS7ZlYlXV2bDChPRLY16EAu" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:05 |  << <iq to="test-domain.com" id="y1wkXofCFv4zr8JPWhPFw9z" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325 >> <iq to="test-domain.com" id="y1wkXofCFv4zr8JPWhPFw9z" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 |  << <iq id="T0rdHBfWXYo4siAtqjKV16D" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325 >> <iq id="T0rdHBfWXYo4siAtqjKV16D" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 |  >> <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326" xmlns="jabber:client" id="QNUdHKxlTP6hCGECCeL0t4z"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326</jid></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-325 << <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326" xmlns="jabber:client" id="QNUdHKxlTP6hCGECCeL0t4z"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326</jid></bind></iq>

2022-08-28 22:43:05 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:05 |  >> <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="JS7ZlYlXV2bDChPRLY16EAu"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327</jid></bind></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326 << <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="JS7ZlYlXV2bDChPRLY16EAu"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327</jid></bind></iq>

2022-08-28 22:43:05 |  << <iq to="test-domain.com" id="3FoneVYnVUfNQ9FCDx5mPVc" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-326 >> <iq to="test-domain.com" id="3FoneVYnVUfNQ9FCDx5mPVc" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 |  << <iq id="ZLEEKMS8gP8JABnO3p4Bzqf" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 >> <iq id="ZLEEKMS8gP8JABnO3p4Bzqf" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:05 |  << <iq to="test-domain.com" id="E8JVUfNQ9FCDx5mPVcr9v3y" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 >> <iq to="test-domain.com" id="E8JVUfNQ9FCDx5mPVcr9v3y" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:05 |  << <iq id="GMDZhO5xm7v1ezpan1fxw7i" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 >> <iq id="GMDZhO5xm7v1ezpan1fxw7i" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 |  >> <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="y1wkXofCFv4zr8JPWhPFw9z" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 << <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="y1wkXofCFv4zr8JPWhPFw9z" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:05 |  >> <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="T0rdHBfWXYo4siAtqjKV16D"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 << <iq type="result" to="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327" xmlns="jabber:client" id="T0rdHBfWXYo4siAtqjKV16D"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:05 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:05 |  >> <presence to="jaxmpp__qdhiwl0559@test-domain.com" xmlns="jabber:client" from="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp"/></presence>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327 << <presence to="jaxmpp__qdhiwl0559@test-domain.com" xmlns="jabber:client" from="jaxmpp__qdhiwl0559@test-domain.com/1608752850-tigase-327"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp"/></presence>

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

testStateAfterAuthTimeoutSocket 20.281s
2022-08-28 22:43:05 |

2022-08-28 22:43:05 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:43:05 | ------------------------------------

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: null->connecting

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

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222]

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: connecting->connected

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:05 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:05 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4088] Start TLS

2022-08-28 22:43:05 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:05 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4090] Proceeding TLS

2022-08-28 22:43:05 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4090] Start handshake

2022-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:05 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:05 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:05 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4090] Connector  state changed: connected->disconnected

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4090] Stream terminated

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: null->connecting

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

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222]

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connecting->connected

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4088] Start TLS

2022-08-28 22:43:25 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:25 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4095] Proceeding TLS

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4095] Start handshake

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:25 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:25 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX25iYm52ZjA1NjAscj12ZzdUUDY4UTZzYjBPcFk0TDZmWg==</auth>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX25iYm52ZjA1NjAscj12ZzdUUDY4UTZzYjBPcFk0TDZmWg==</auth>

2022-08-28 22:43:25 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12ZzdUUDY4UTZzYjBPcFk0TDZmWmxIbk9NUmM1ZUtVdXVHUThIeG1VLHM9aDZFUnBwUTJ4ajc0V0E9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12ZzdUUDY4UTZzYjBPcFk0TDZmWmxIbk9NUmM1ZUtVdXVHUThIeG1VLHM9aDZFUnBwUTJ4ajc0V0E9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:25 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dmc3VFA2OFE2c2IwT3BZNEw2ZlpsSG5PTVJjNWVLVXV1R1E4SHhtVSxwPXlsK2EyWlMwNlU2c2VqV1lFNFVVejAwU09MOGJDKzJKYWZUalM1UGFFc1U9</response>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dmc3VFA2OFE2c2IwT3BZNEw2ZlpsSG5PTVJjNWVLVXV1R1E4SHhtVSxwPXlsK2EyWlMwNlU2c2VqV1lFNFVVejAwU09MOGJDKzJKYWZUalM1UGFFc1U9</response>

2022-08-28 22:43:25 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ORVRvcXJLZzdEZysyaEhIVGtvS1p6MUdoRnhmNW5taGNJSVZlQmhxM1hZPQ==</success>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ORVRvcXJLZzdEZysyaEhIVGtvS1p6MUdoRnhmNW5taGNJSVZlQmhxM1hZPQ==</success>

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:25 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="tRKQ8yqesdUhGNLABvgZlYl" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com >> <iq xmlns="jabber:client" id="tRKQ8yqesdUhGNLABvgZlYl" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328" xmlns="jabber:client" id="tRKQ8yqesdUhGNLABvgZlYl"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328</jid></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328" xmlns="jabber:client" id="tRKQ8yqesdUhGNLABvgZlYl"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328</jid></bind></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="7VUxfyxn0tjUdHp07vmLNND" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328 >> <iq xmlns="jabber:client" id="7VUxfyxn0tjUdHp07vmLNND" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="8fQ9m9Bsn7wr9jOJJOFBpRa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328 >> <iq xmlns="jabber:client" id="8fQ9m9Bsn7wr9jOJJOFBpRa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329" xmlns="jabber:client" id="7VUxfyxn0tjUdHp07vmLNND"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329</jid></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329" xmlns="jabber:client" id="7VUxfyxn0tjUdHp07vmLNND"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329</jid></bind></iq>

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="x9wIq9M1aLHslZeVdIPVRUV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328 >> <iq xmlns="jabber:client" id="x9wIq9M1aLHslZeVdIPVRUV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="8fQ9m9Bsn7wr9jOJJOFBpRa"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330</jid></bind></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-328 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="8fQ9m9Bsn7wr9jOJJOFBpRa"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330</jid></bind></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="916yxn0tjUdHp07vmLNNDIv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq xmlns="jabber:client" id="916yxn0tjUdHp07vmLNNDIv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329" xmlns="jabber:client" id="x9wIq9M1aLHslZeVdIPVRUV"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-329" xmlns="jabber:client" id="x9wIq9M1aLHslZeVdIPVRUV"/>

2022-08-28 22:43:25 |  << <iq xmlns="jabber:client" id="rUJct0scIOCxyzgX5eT5qjZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq xmlns="jabber:client" id="rUJct0scIOCxyzgX5eT5qjZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-08-28 22:43:25 |  << <iq to="test-domain.com" id="xczOCxyzgX5eT5qjZgV7fGt" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="xczOCxyzgX5eT5qjZgV7fGt" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:25 |  >> <enabled xmlns="urn:xmpp:sm:3" max="60" id="9c34183a-2586-4635-bbd8-b75f896039d9" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="9c34183a-2586-4635-bbd8-b75f896039d9" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:25 |  << <iq id="3TCP8JABnO3p4BzqfLxgDxq" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq id="3TCP8JABnO3p4BzqfLxgDxq" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="916yxn0tjUdHp07vmLNNDIv"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="916yxn0tjUdHp07vmLNNDIv"/>

2022-08-28 22:43:25 |  << <iq to="test-domain.com" id="721LHslZeVdIPVRUV7AdHBf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="721LHslZeVdIPVRUV7AdHBf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="rUJct0scIOCxyzgX5eT5qjZ"/>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="rUJct0scIOCxyzgX5eT5qjZ"/>

2022-08-28 22:43:25 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="3TCP8JABnO3p4BzqfLxgDxq"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="3TCP8JABnO3p4BzqfLxgDxq"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 |  << <iq id="Ko3LO1jDs1jYZfHrkJwugQ4" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq id="Ko3LO1jDs1jYZfHrkJwugQ4" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 |  << <iq to="test-domain.com" id="4fAWlO3hCFDwvn2tdr4fLSN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="4fAWlO3hCFDwvn2tdr4fLSN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:25 |  << <iq id="ievjOJJOFBpRapScGGKuh2x" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <iq id="ievjOJJOFBpRapScGGKuh2x" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:25 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:25 |  >> <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="xczOCxyzgX5eT5qjZgV7fGt" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:25 | jaxmpp_ :: jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330 << <iq type="result" to="jaxmpp__nbbnvf0560@test-domain.com/1608752850-tigase-330" xmlns="jabber:client" id="xczOCxyzgX5eT5qjZgV7fGt" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connected->disconnecting

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-08-28 22:43:25 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-08-28 22:43:25 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4095] Connector  state changed: disconnecting->disconnected

testStateAfterAuthTimeoutWebSocket 20.403s
2022-08-28 22:43:26 |

2022-08-28 22:43:26 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:43:26 | ------------------------------------

2022-08-28 22:43:26 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-08-28 22:43:26 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-08-28 22:43:26 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-08-28 22:43:26 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-08-28 22:43:26 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:26 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:26 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:26 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

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

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

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

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:46 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

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

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:46 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzZseXJ0MzA1NjEscj1XZWx2OG5rUjNEMWdmTXhPRTVMbw==</auth>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzZseXJ0MzA1NjEscj1XZWx2OG5rUjNEMWdmTXhPRTVMbw==</auth>

2022-08-28 22:43:46 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XZWx2OG5rUjNEMWdmTXhPRTVMb2JrRExucGxPQk95RHh2UUVLMjhyLHM9eU0vdzBnenR2OEg0MWc9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XZWx2OG5rUjNEMWdmTXhPRTVMb2JrRExucGxPQk95RHh2UUVLMjhyLHM9eU0vdzBnenR2OEg0MWc9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:46 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2Vsdjhua1IzRDFnZk14T0U1TG9ia0RMbnBsT0JPeUR4dlFFSzI4cixwPUFQVUpZc2V5enh0b0I3K3ErZXVBb1dtSlFHZEJIT3N3elRuc1VUTlJhelk9</response>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2Vsdjhua1IzRDFnZk14T0U1TG9ia0RMbnBsT0JPeUR4dlFFSzI4cixwPUFQVUpZc2V5enh0b0I3K3ErZXVBb1dtSlFHZEJIT3N3elRuc1VUTlJhelk9</response>

2022-08-28 22:43:46 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oVGtLTTJkUmZrVkx2dDRBWHora0hGYW5lWkNRMFhKYUUxTmF0MVM3SzRjPQ==</success>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oVGtLTTJkUmZrVkx2dDRBWHora0hGYW5lWkNRMFhKYUUxTmF0MVM3SzRjPQ==</success>

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:46 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:46 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:46 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

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

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

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

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="piAEl8lKWaEGm1wv8HzcPXa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com >> <iq xmlns="jabber:client" id="piAEl8lKWaEGm1wv8HzcPXa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="evb0iZfvcvhURZbpgBgYeMW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com >> <iq xmlns="jabber:client" id="evb0iZfvcvhURZbpgBgYeMW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="TpR2lTP6hCGECCeL0t4zjGN" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com >> <iq xmlns="jabber:client" id="TpR2lTP6hCGECCeL0t4zjGN" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-331" xmlns="jabber:client" id="piAEl8lKWaEGm1wv8HzcPXa"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-331</jid></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-331" xmlns="jabber:client" id="piAEl8lKWaEGm1wv8HzcPXa"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-331</jid></bind></iq>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-332" xmlns="jabber:client" id="evb0iZfvcvhURZbpgBgYeMW"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-332</jid></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-332" xmlns="jabber:client" id="evb0iZfvcvhURZbpgBgYeMW"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-332</jid></bind></iq>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="TpR2lTP6hCGECCeL0t4zjGN"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333</jid></bind></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="TpR2lTP6hCGECCeL0t4zjGN"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333</jid></bind></iq>

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="InJZrfMXbnWZfQJJFnct0sc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="InJZrfMXbnWZfQJJFnct0sc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="0nHZmIJWlO3hCFDwvn2tdr4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="0nHZmIJWlO3hCFDwvn2tdr4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 |  << <iq xmlns="jabber:client" id="inFCqXbItdDj4duq8Ay6vur" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="inFCqXbItdDj4duq8Ay6vur" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="InJZrfMXbnWZfQJJFnct0sc"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="InJZrfMXbnWZfQJJFnct0sc"/>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="0nHZmIJWlO3hCFDwvn2tdr4"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="0nHZmIJWlO3hCFDwvn2tdr4"/>

2022-08-28 22:43:46 |  >> <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="inFCqXbItdDj4duq8Ay6vur"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 << <iq type="result" to="jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333" xmlns="jabber:client" id="inFCqXbItdDj4duq8Ay6vur"/>

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="xrPjCxyzgX5eT5qjZgV7fGt" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:46 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

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

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="eBhcGLNBoT3sXbzbOHsm0k2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:46 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:46 |  << <iq to="test-domain.com" id="4sOndyxfyxn0tjUdHp07vmL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="4sOndyxfyxn0tjUdHp07vmL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:46 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:46 |  << <iq id="CDj1t7i1lWl3obDhKBtiDxh" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq id="CDj1t7i1lWl3obDhKBtiDxh" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:46 |  << <iq id="8CeUSbFADDyvhzkLNWV7rVi" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq id="8CeUSbFADDyvhzkLNWV7rVi" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:46 |  << <iq id="eFlkWhPFw9zu1jPHQLACwm6" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <iq id="eFlkWhPFw9zu1jPHQLACwm6" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:46 |  >> <enabled xmlns="urn:xmpp:sm:3" max="60" id="b168eab2-4518-4872-8573-cad9eb4222a4" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__6lyrt30561@test-domain.com/1608752850-tigase-333 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="b168eab2-4518-4872-8573-cad9eb4222a4" resume="true" location="ed1b7dd8a1b3"/>

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

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2022-08-28 22:43:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureBosh 0.726s
2022-08-28 22:43:46 |

2022-08-28 22:43:46 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:43:46 | ------------------------------------

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

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

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

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

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-08-28 22:43:46 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:46 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-08-28 22:43:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:46 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl6dm9vcTA1NjIscj1hYkxLaklnZTljVXZvZWxIdjRHdQ==</auth>

2022-08-28 22:43:46 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl6dm9vcTA1NjIscj1hYkxLaklnZTljVXZvZWxIdjRHdQ==</auth>

2022-08-28 22:43:47 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hYkxLaklnZTljVXZvZWxIdjRHdUVRYlplU1YwZzV0NFRjUGhDWFU1LHM9NGQ5V0k4RVJJMGhGM3c9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hYkxLaklnZTljVXZvZWxIdjRHdUVRYlplU1YwZzV0NFRjUGhDWFU1LHM9NGQ5V0k4RVJJMGhGM3c9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:47 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YWJMS2pJZ2U5Y1V2b2VsSHY0R3VFUWJaZVNWMGc1dDRUY1BoQ1hVNSxwPUt6OS8reVZBY2FnbEx6VHhsL2ZsaXpza0FyZGRSVFpmSDlmWHo5cTVrRVE9</response>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YWJMS2pJZ2U5Y1V2b2VsSHY0R3VFUWJaZVNWMGc1dDRUY1BoQ1hVNSxwPUt6OS8reVZBY2FnbEx6VHhsL2ZsaXpza0FyZGRSVFpmSDlmWHo5cTVrRVE9</response>

2022-08-28 22:43:47 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13V0FTb3VvdGtzckI0YjkzK29VTXU1eExER0c1Q3ZqNG1uQXZNcXQzK3lzPQ==</success>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13V0FTb3VvdGtzckI0YjkzK29VTXU1eExER0c1Q3ZqNG1uQXZNcXQzK3lzPQ==</success>

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:47 |  << <iq xmlns="jabber:client" id="Xj917i2m2sU7ITUfFodJIT9" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com >> <iq xmlns="jabber:client" id="Xj917i2m2sU7ITUfFodJIT9" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:47 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:47 |  >> <iq type="result" to="jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334" xmlns="jabber:client" id="Xj917i2m2sU7ITUfFodJIT9"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334</jid></bind></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com << <iq type="result" to="jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334" xmlns="jabber:client" id="Xj917i2m2sU7ITUfFodJIT9"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334</jid></bind></iq>

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:47 |  << <iq to="test-domain.com" id="9syrjV6FHGLNBoT3sXbzbOH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334 >> <iq to="test-domain.com" id="9syrjV6FHGLNBoT3sXbzbOH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:47 |  << <iq id="bJlgM1p6BtX6jT8jTZ1u3aM" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334 >> <iq id="bJlgM1p6BtX6jT8jTZ1u3aM" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__9zvooq0562@test-domain.com/1608752850-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

testStateAfterConnectionFailureSocket 0.240s
2022-08-28 22:43:47 |

2022-08-28 22:43:47 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:43:47 | ------------------------------------

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: null->connecting

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

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222]

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing. Trying next.

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: connecting->disconnected

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: null->connecting

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

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222]

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connecting->connected

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms

2022-08-28 22:43:47 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4148] Start TLS

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:47 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4152] Proceeding TLS

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4152] Start handshake

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:47 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:47 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzNiYmIzZzA1NjMscj0zRTVYT2dtTFg5T0NxbmswR2VzUg==</auth>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzNiYmIzZzA1NjMscj0zRTVYT2dtTFg5T0NxbmswR2VzUg==</auth>

2022-08-28 22:43:47 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zRTVYT2dtTFg5T0NxbmswR2VzUlBhTjRtRnl1Q2F1Nm44c0RiNDlLLHM9ZGxDcURFWEliMmRkSEE9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zRTVYT2dtTFg5T0NxbmswR2VzUlBhTjRtRnl1Q2F1Nm44c0RiNDlLLHM9ZGxDcURFWEliMmRkSEE9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:47 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0U1WE9nbUxYOU9DcW5rMEdlc1JQYU40bUZ5dUNhdTZuOHNEYjQ5SyxwPUFSbzNPSEhiVWVyUVBtdUp6NnBlZlYzYS9Nb3F0SGxaSFpmUkppdUhnVkk9</response>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0U1WE9nbUxYOU9DcW5rMEdlc1JQYU40bUZ5dUNhdTZuOHNEYjQ5SyxwPUFSbzNPSEhiVWVyUVBtdUp6NnBlZlYzYS9Nb3F0SGxaSFpmUkppdUhnVkk9</response>

2022-08-28 22:43:47 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12dXBZcS9GWHZjdkptWkx2ekdyVkxIS0R2UGRmNElLYTUwU0x1YW1pZmc4PQ==</success>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj12dXBZcS9GWHZjdkptWkx2ekdyVkxIS0R2UGRmNElLYTUwU0x1YW1pZmc4PQ==</success>

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:47 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-08-28 22:43:47 |  << <iq xmlns="jabber:client" id="0EYxsU7ITUfFodJIT9AzpPQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com >> <iq xmlns="jabber:client" id="0EYxsU7ITUfFodJIT9AzpPQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:47 |  >> <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="0EYxsU7ITUfFodJIT9AzpPQ"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335</jid></bind></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com << <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="0EYxsU7ITUfFodJIT9AzpPQ"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335</jid></bind></iq>

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:47 |  << <iq xmlns="jabber:client" id="HOqq6FHGLNBoT3sXbzbOHsm" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 >> <iq xmlns="jabber:client" id="HOqq6FHGLNBoT3sXbzbOHsm" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:47 |  >> <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="HOqq6FHGLNBoT3sXbzbOHsm"/>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="HOqq6FHGLNBoT3sXbzbOHsm"/>

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-08-28 22:43:47 |  << <iq to="test-domain.com" id="sQukIS2oakXofCFv4zr8JPW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 >> <iq to="test-domain.com" id="sQukIS2oakXofCFv4zr8JPW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:47 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:47 |  >> <enabled xmlns="urn:xmpp:sm:3" max="60" id="100d75f4-0ea3-446e-a9e2-3f5425c9d4dc" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="100d75f4-0ea3-446e-a9e2-3f5425c9d4dc" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:47 |  << <iq id="XsijHsm0k24rmbupZ2vjSdN" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 >> <iq id="XsijHsm0k24rmbupZ2vjSdN" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:47 |  >> <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="sQukIS2oakXofCFv4zr8JPW" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="sQukIS2oakXofCFv4zr8JPW" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity type="router" category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><identity type="im" category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b12048/68bd9eb2"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-08-28 22:43:47 |  >> <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="XsijHsm0k24rmbupZ2vjSdN"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <iq type="result" to="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335" xmlns="jabber:client" id="XsijHsm0k24rmbupZ2vjSdN"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connected->disconnecting

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream

2022-08-28 22:43:47 |  >> <presence to="jaxmpp__3bbb3g0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp"/></presence>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <presence to="jaxmpp__3bbb3g0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp"/></presence>

2022-08-28 22:43:47 |  >> <message to="jaxmpp__3bbb3g0563@test-domain.com" xmlns="jabber:client" from="test-domain.com"><body>Wecome to e2c2aee0-b298-4137-8271-7b4cc0dcd75a
This message was set at: Sun Aug 28 22:19:54 PDT 2022</body><delay xmlns="urn:xmpp:delay" stamp="2022-08-29T05:43:47.602Z" from="test-domain.com">Offline Storage - ed1b7dd8a1b3</delay></message>

2022-08-28 22:43:47 | jaxmpp_ :: jaxmpp__3bbb3g0563@test-domain.com/1608752850-tigase-335 << <message to="jaxmpp__3bbb3g0563@test-domain.com" xmlns="jabber:client" from="test-domain.com"><body>Wecome to e2c2aee0-b298-4137-8271-7b4cc0dcd75a
This message was set at: Sun Aug 28 22:19:54 PDT 2022</body><delay xmlns="urn:xmpp:delay" stamp="2022-08-29T05:43:47.602Z" from="test-domain.com">Offline Storage - ed1b7dd8a1b3</delay></message>

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4152] Connector  state changed: disconnecting->disconnected

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4152] Stream terminated

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-08-28 22:43:47 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:47 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureWebSocket 0.345s
2022-08-28 22:43:48 |

2022-08-28 22:43:48 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-08-28 22:43:48 | ------------------------------------

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:48 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><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><register xmlns="http://jabber.org/features/iq-register"/><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-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-08-28 22:43:48 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2ZibHVieDA1NjQscj1DRFQ2MU9Eb1dFMXdQOFFobklpQg==</auth>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2ZibHVieDA1NjQscj1DRFQ2MU9Eb1dFMXdQOFFobklpQg==</auth>

2022-08-28 22:43:48 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DRFQ2MU9Eb1dFMXdQOFFobklpQnFUVGdQRWlJZXVpWWVKaXE1UEFrLHM9cW9mRUJyRnRlNHVnbXc9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DRFQ2MU9Eb1dFMXdQOFFobklpQnFUVGdQRWlJZXVpWWVKaXE1UEFrLHM9cW9mRUJyRnRlNHVnbXc9PSxpPTQwOTY=</challenge>

2022-08-28 22:43:48 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0RUNjFPRG9XRTF3UDhRaG5JaUJxVFRnUEVpSWV1aVllSmlxNVBBayxwPVRkS1dsSzgvZmJidmkvTXZZNVpsOCtZYVdOK0FHbzlqTFh6blRzUlVzSFU9</response>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0RUNjFPRG9XRTF3UDhRaG5JaUJxVFRnUEVpSWV1aVllSmlxNVBBayxwPVRkS1dsSzgvZmJidmkvTXZZNVpsOCtZYVdOK0FHbzlqTFh6blRzUlVzSFU9</response>

2022-08-28 22:43:48 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IRDA0YTRqc08wOXZSSFhZNTFWaGJvd3dBSkpGZitKc1BUbGVCOGgyNEwwPQ==</success>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IRDA0YTRqc08wOXZSSFhZNTFWaGJvd3dBSkpGZitKc1BUbGVCOGgyNEwwPQ==</success>

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-08-28 22:43:48 |  >> <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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@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 xmlns="http://jabber.org/protocol/caps" ver="ef9S3leJ0U4rOFv/Dc8k0m8Mc8k=" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server"/></features>

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-08-28 22:43:48 |  << <iq xmlns="jabber:client" id="pK2y9KzcQYgUOVk7m9t0rbC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com >> <iq xmlns="jabber:client" id="pK2y9KzcQYgUOVk7m9t0rbC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-08-28 22:43:48 |  >> <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="pK2y9KzcQYgUOVk7m9t0rbC"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336</jid></bind></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com << <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="pK2y9KzcQYgUOVk7m9t0rbC"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336</jid></bind></iq>

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-08-28 22:43:48 |  << <iq xmlns="jabber:client" id="xOc36vur0r3aLPUhV8FBdCl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 >> <iq xmlns="jabber:client" id="xOc36vur0r3aLPUhV8FBdCl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-08-28 22:43:48 |  >> <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="xOc36vur0r3aLPUhV8FBdCl"/>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 << <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="xOc36vur0r3aLPUhV8FBdCl"/>

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-08-28 22:43:48 |  << <iq to="test-domain.com" id="sXByaMQ0oMRcRQ7pSbFADDy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 >> <iq to="test-domain.com" id="sXByaMQ0oMRcRQ7pSbFADDy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-08-28 22:43:48 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-08-28 22:43:48 |  << <iq id="pN5El8lKWaEGm1wv8HzcPXa" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 >> <iq id="pN5El8lKWaEGm1wv8HzcPXa" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:48 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-08-28 22:43:48 |  >> <enabled xmlns="urn:xmpp:sm:3" max="60" id="ca071202-2660-4566-9823-0eafa2bc6024" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 << <enabled xmlns="urn:xmpp:sm:3" max="60" id="ca071202-2660-4566-9823-0eafa2bc6024" resume="true" location="ed1b7dd8a1b3"/>

2022-08-28 22:43:48 |  >> <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="pN5El8lKWaEGm1wv8HzcPXa"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:48 | jaxmpp_ :: jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336 << <iq type="result" to="jaxmpp__fblubx0564@test-domain.com/1608752850-tigase-336" xmlns="jabber:client" id="pN5El8lKWaEGm1wv8HzcPXa"><query xmlns="jabber:iq:roster"/></iq>

2022-08-28 22:43:48 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-08-28 22:43:48 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]