Generated by TestNG with ReportNG at 22:23 PDT on Monday 09 May 2022
root@21fb2cc9076b / Java 17.0.2 (Private Build) / Linux 4.14.186-146.268.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 64.344s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.498s
2022-05-09 22:45:47 |

2022-05-09 22:45:47 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-05-09 22:45:47 | ------------------------------------

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

2022-05-09 22:45:47 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-05-09 22:45:47 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-05-09 22:45: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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2022-05-09 22:45:47 | jaxmpp_ :: jaxmpp__po81dh0559@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-05-09 22:46:07 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

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

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-05-09 22:46:07 |  >> <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-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@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-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-05-09 22:46:07 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3BvODFkaDA1NTkscj16cjVDQ0dQTzRZUm1IUHJGdUNjVQ==</auth>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3BvODFkaDA1NTkscj16cjVDQ0dQTzRZUm1IUHJGdUNjVQ==</auth>

2022-05-09 22:46:07 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16cjVDQ0dQTzRZUm1IUHJGdUNjVTN3YTk1RmJvR2trc3NiMkRNRklKLHM9QXExdFc3aDdieTVWdlE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16cjVDQ0dQTzRZUm1IUHJGdUNjVTN3YTk1RmJvR2trc3NiMkRNRklKLHM9QXExdFc3aDdieTVWdlE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:07 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9enI1Q0NHUE80WVJtSFByRnVDY1Uzd2E5NUZib0dra3NzYjJETUZJSixwPWIyQjAvR3VrWCtTaWtZZnJvQVh3TFpiZkpNc0dVL3VQK0Y1YnNYdGFoTFk9</response>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9enI1Q0NHUE80WVJtSFByRnVDY1Uzd2E5NUZib0dra3NzYjJETUZJSixwPWIyQjAvR3VrWCtTaWtZZnJvQVh3TFpiZkpNc0dVL3VQK0Y1YnNYdGFoTFk9</response>

2022-05-09 22:46:07 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj05azk3dzk5Wlp0elJRR0RZbGxjR3FzZFR0bW1aY1QxVk5UdWJJdFdzaVlNPQ==</success>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj05azk3dzk5Wlp0elJRR0RZbGxjR3FzZFR0bW1aY1QxVk5UdWJJdFdzaVlNPQ==</success>

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:07 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 |  << <iq xmlns="jabber:client" id="mXe6xs3rW4q3btj5aq6Gw7t" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com >> <iq xmlns="jabber:client" id="mXe6xs3rW4q3btj5aq6Gw7t" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 |  << <iq xmlns="jabber:client" id="uZi5fBzBcueW29x6hGp9GPM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com >> <iq xmlns="jabber:client" id="uZi5fBzBcueW29x6hGp9GPM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:07 |  << <iq xmlns="jabber:client" id="iQPpQbDCzwbHs6ubrZl9iGC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com >> <iq xmlns="jabber:client" id="iQPpQbDCzwbHs6ubrZl9iGC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:07 |  >> <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326" xmlns="jabber:client" id="mXe6xs3rW4q3btj5aq6Gw7t" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326</jid></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com << <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326" xmlns="jabber:client" id="mXe6xs3rW4q3btj5aq6Gw7t" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326</jid></bind></iq>

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

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

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326 >> <iq to="test-domain.com" id="wOHNXnKAqkOHDiFsXfSdyza" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:07 |  << <iq id="u2lbrZl9iGCIAfJu3evl4Bk" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-326 >> <iq id="u2lbrZl9iGCIAfJu3evl4Bk" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:07 |  >> <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327" xmlns="jabber:client" id="uZi5fBzBcueW29x6hGp9GPM" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327</jid></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327 << <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327" xmlns="jabber:client" id="uZi5fBzBcueW29x6hGp9GPM" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327</jid></bind></iq>

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:07 |  << <iq to="test-domain.com" id="5RM6Gw7tY1an5yzgZ0vhU9G" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327 >> <iq to="test-domain.com" id="5RM6Gw7tY1an5yzgZ0vhU9G" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:07 |  >> <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328" xmlns="jabber:client" id="iQPpQbDCzwbHs6ubrZl9iGC" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328</jid></bind></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327 << <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328" xmlns="jabber:client" id="iQPpQbDCzwbHs6ubrZl9iGC" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328</jid></bind></iq>

2022-05-09 22:46:07 |  << <iq id="OUTx6HFGHMHJweKHt3tpOIG" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-327 >> <iq id="OUTx6HFGHMHJweKHt3tpOIG" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

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

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328 >> <iq to="test-domain.com" id="DhYoRXWX27zwv8JutdMTath" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:07 |  << <iq id="t07OPJzvtWYcSUT14dy9DEL" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328 >> <iq id="t07OPJzvtWYcSUT14dy9DEL" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:07 |  >> <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328" from="test-domain.com" xmlns="jabber:client" id="wOHNXnKAqkOHDiFsXfSdyza" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328 << <iq to="jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328" from="test-domain.com" xmlns="jabber:client" id="wOHNXnKAqkOHDiFsXfSdyza" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2022-05-09 22:46:07 | jaxmpp_ :: jaxmpp__po81dh0559@test-domain.com/2095355307-tigase-328 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2022-05-09 22:46:07 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-05-09 22:46:07 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500
testStateAfterAuthTimeoutSocket 20.283s
2022-05-09 22:46:08 |

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

2022-05-09 22:46:08 | ------------------------------------

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

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

2022-05-09 22:46:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2022-05-09 22:46:08 |  >> <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-05-09 22:46:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4091] Start TLS

2022-05-09 22:46:08 | jaxmpp_ :: jaxmpp__f3mv500560@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-05-09 22:46:08 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2022-05-09 22:46:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4093] Proceeding TLS

2022-05-09 22:46:08 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4093] Start handshake

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

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

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4093] Connector  state changed: connected->disconnected

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4093] Stream terminated

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

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

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

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

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2022-05-09 22:46:28 |  >> <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-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4091] Start TLS

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@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-05-09 22:46:28 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4098] Proceeding TLS

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4098] Start handshake

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

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

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

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

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2YzbXY1MDA1NjAscj16Q25NMEJVRFg5QUFxUm85TVh2Vg==</auth>

2022-05-09 22:46:28 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16Q25NMEJVRFg5QUFxUm85TVh2VnVISjZ1MTF1bjBpN1dFVzJMMnc2LHM9bW5NMVVISUlFaFVnc2c9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16Q25NMEJVRFg5QUFxUm85TVh2VnVISjZ1MTF1bjBpN1dFVzJMMnc2LHM9bW5NMVVISUlFaFVnc2c9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:28 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekNuTTBCVURYOUFBcVJvOU1YdlZ1SEo2dTExdW4waTdXRVcyTDJ3NixwPVdqMDVOcllodExIbFl4eGpGQmpMU0xqRmRCSS9FWUloK0xiNWJEcDVSTVE9</response>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ekNuTTBCVURYOUFBcVJvOU1YdlZ1SEo2dTExdW4waTdXRVcyTDJ3NixwPVdqMDVOcllodExIbFl4eGpGQmpMU0xqRmRCSS9FWUloK0xiNWJEcDVSTVE9</response>

2022-05-09 22:46:28 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WUGNkTXJIRGJ4WmVyb1V4NWk2azMvTzBWaWVrREZRUnVBTnFLQzRUNk5JPQ==</success>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WUGNkTXJIRGJ4WmVyb1V4NWk2azMvTzBWaWVrREZRUnVBTnFLQzRUNk5JPQ==</success>

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

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

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

2022-05-09 22:46:28 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:28 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:28 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

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

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

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

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

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

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

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

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

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

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329" xmlns="jabber:client" id="BYTk8qV5ct4bHM1aNCJJOXi" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329</jid></bind></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329" xmlns="jabber:client" id="BYTk8qV5ct4bHM1aNCJJOXi" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329</jid></bind></iq>

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

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329 >> <iq xmlns="jabber:client" id="UgF09DkQY9nR5DgCus4dFmN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="a8l05iDBADofwxl2pcxpSWa" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330</jid></bind></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-329 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="a8l05iDBADofwxl2pcxpSWa" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330</jid></bind></iq>

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

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330 >> <iq xmlns="jabber:client" id="eZOfSdyzaPVcJQPZ2gOPJzv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="KXMbKX2x6HFGHMHJweKHt3t" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331</jid></bind></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="KXMbKX2x6HFGHMHJweKHt3t" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331</jid></bind></iq>

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

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq xmlns="jabber:client" id="glQr0tYr9EDErduaCrX1phy" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="UgF09DkQY9nR5DgCus4dFmN" type="result"/>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="UgF09DkQY9nR5DgCus4dFmN" type="result"/>

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

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq to="test-domain.com" id="nkL9GvlKGEv5hVjCkUiKznM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:28 |  >> <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="5680343c-d042-4d8e-ab5f-a23396359d3f"/>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="5680343c-d042-4d8e-ab5f-a23396359d3f"/>

2022-05-09 22:46:28 |  << <iq id="VnSbHs6ubrZl9iGCIAfJu3e" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq id="VnSbHs6ubrZl9iGCIAfJu3e" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="eZOfSdyzaPVcJQPZ2gOPJzv" type="result"/>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-330" xmlns="jabber:client" id="eZOfSdyzaPVcJQPZ2gOPJzv" type="result"/>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="glQr0tYr9EDErduaCrX1phy" type="result"/>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="glQr0tYr9EDErduaCrX1phy" type="result"/>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq to="test-domain.com" id="s4VkW5fBzBcueW29x6hGp9G" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:28 |  << <iq id="yoSuY2k8qV5ct4bHM1aNCJJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq id="yoSuY2k8qV5ct4bHM1aNCJJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq to="test-domain.com" id="rnNV2mVVXh12aAEsZdsZ6fP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:28 |  << <iq id="K6WumburUjT8BAjXY8yjHvn" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <iq id="K6WumburUjT8BAjXY8yjHvn" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" from="test-domain.com" xmlns="jabber:client" id="nkL9GvlKGEv5hVjCkUiKznM" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" from="test-domain.com" xmlns="jabber:client" id="nkL9GvlKGEv5hVjCkUiKznM" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

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

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="VnSbHs6ubrZl9iGCIAfJu3e" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="VnSbHs6ubrZl9iGCIAfJu3e" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4098] Connector  state changed: disconnecting->disconnected

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4098] Stream terminated

2022-05-09 22:46:28 |  >> <presence to="jaxmpp__f3mv500560@test-domain.com" from="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <presence to="jaxmpp__f3mv500560@test-domain.com" from="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-05-09 22:46:28 |  >> <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="yoSuY2k8qV5ct4bHM1aNCJJ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:28 | jaxmpp_ :: jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331 << <iq to="jaxmpp__f3mv500560@test-domain.com/2095355307-tigase-331" xmlns="jabber:client" id="yoSuY2k8qV5ct4bHM1aNCJJ" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

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

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testStateAfterAuthTimeoutWebSocket 20.382s
2022-05-09 22:46:28 |

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

2022-05-09 22:46:28 | ------------------------------------

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

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

2022-05-09 22:46:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

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

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

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

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

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

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

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

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

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

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

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

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

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

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

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

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-05-09 22:46:48 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX24zY3ljODA1NjEscj02czUyUFY3TlNWbEZ1ZER1UlFSbg==</auth>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX24zY3ljODA1NjEscj02czUyUFY3TlNWbEZ1ZER1UlFSbg==</auth>

2022-05-09 22:46:48 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02czUyUFY3TlNWbEZ1ZER1UlFSbmJRZ3NqdG9DRlZ0Y1dLODhHYnJtLHM9OWxmaFZ3MTcxWlJCS1E9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02czUyUFY3TlNWbEZ1ZER1UlFSbmJRZ3NqdG9DRlZ0Y1dLODhHYnJtLHM9OWxmaFZ3MTcxWlJCS1E9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:48 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NnM1MlBWN05TVmxGdWREdVJRUm5iUWdzanRvQ0ZWdGNXSzg4R2JybSxwPW1teWlMUHlwNytMWjRNeEYzKzduT29aay8xMzBDZUJEck00TkRXMVU5TkE9</response>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NnM1MlBWN05TVmxGdWREdVJRUm5iUWdzanRvQ0ZWdGNXSzg4R2JybSxwPW1teWlMUHlwNytMWjRNeEYzKzduT29aay8xMzBDZUJEck00TkRXMVU5TkE9</response>

2022-05-09 22:46:48 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LS0JSM0xDK0Z2OGhLMU0yVnFFMzI4ZHBza2J3c24zOXljWGUvcm5IVHBvPQ==</success>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LS0JSM0xDK0Z2OGhLMU0yVnFFMzI4ZHBza2J3c24zOXljWGUvcm5IVHBvPQ==</success>

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46: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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46: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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46: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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

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

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

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

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="XsS5m0dv7BFkKKY6hNCjKxp" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com >> <iq xmlns="jabber:client" id="XsS5m0dv7BFkKKY6hNCjKxp" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="OgggyBtiVeBx8scBhFHRIwi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com >> <iq xmlns="jabber:client" id="OgggyBtiVeBx8scBhFHRIwi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="9e8MAfChTaNITO7vm3u7zcA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com >> <iq xmlns="jabber:client" id="9e8MAfChTaNITO7vm3u7zcA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-332" xmlns="jabber:client" id="XsS5m0dv7BFkKKY6hNCjKxp" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-332</jid></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-332" xmlns="jabber:client" id="XsS5m0dv7BFkKKY6hNCjKxp" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-332</jid></bind></iq>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-333" xmlns="jabber:client" id="OgggyBtiVeBx8scBhFHRIwi" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-333</jid></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-333" xmlns="jabber:client" id="OgggyBtiVeBx8scBhFHRIwi" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-333</jid></bind></iq>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="9e8MAfChTaNITO7vm3u7zcA" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334</jid></bind></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="9e8MAfChTaNITO7vm3u7zcA" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334</jid></bind></iq>

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:48 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="zDjTS0u8lVSPMBxsnSdsp5w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq xmlns="jabber:client" id="zDjTS0u8lVSPMBxsnSdsp5w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="GqEBhGp9GPM14DxqbKDBgII" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq xmlns="jabber:client" id="GqEBhGp9GPM14DxqbKDBgII" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 |  << <iq xmlns="jabber:client" id="whbKRbmOSeCjRKzgztk7mbo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq xmlns="jabber:client" id="whbKRbmOSeCjRKzgztk7mbo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="zDjTS0u8lVSPMBxsnSdsp5w" type="result"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="zDjTS0u8lVSPMBxsnSdsp5w" type="result"/>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="GqEBhGp9GPM14DxqbKDBgII" type="result"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="GqEBhGp9GPM14DxqbKDBgII" type="result"/>

2022-05-09 22:46:48 |  >> <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="whbKRbmOSeCjRKzgztk7mbo" type="result"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 << <iq to="jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334" xmlns="jabber:client" id="whbKRbmOSeCjRKzgztk7mbo" type="result"/>

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq to="test-domain.com" id="wicMVjCkUiKznMDoPZmburU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:48 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq to="test-domain.com" id="immsWn1o7Cn5eEAnPLTfu4o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:48 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq to="test-domain.com" id="auIJxcrdO5i38LNWdOLRMKM" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:48 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:48 |  << <iq id="CwMjMDv29qT7CHwv2zpaFIz" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq id="CwMjMDv29qT7CHwv2zpaFIz" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:48 |  << <iq id="1ommbmOSeCjRKzgztk7mboh" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq id="1ommbmOSeCjRKzgztk7mboh" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:48 |  << <iq id="8swo14dy9DELELyBtiVeBx8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <iq id="8swo14dy9DELELyBtiVeBx8" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:48 |  >> <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="4b124d1d-5e8f-44d5-b2f9-39eac7865ab0"/>

2022-05-09 22:46:48 | jaxmpp_ :: jaxmpp__n3cyc80561@test-domain.com/2095355307-tigase-334 << <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="4b124d1d-5e8f-44d5-b2f9-39eac7865ab0"/>

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

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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

2022-05-09 22:46:48 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected
testStateAfterConnectionFailureBosh 0.751s
2022-05-09 22:46:49 |

2022-05-09 22:46:49 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-05-09 22:46:49 | ------------------------------------

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

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

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

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

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-05-09 22:46:49 |  >> <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-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@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-05-09 22:46:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-05-09 22:46:49 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzRsdW9hcDA1NjIscj0ySUlxOEdJM1ZaNVNJYURVOHBRZQ==</auth>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzRsdW9hcDA1NjIscj0ySUlxOEdJM1ZaNVNJYURVOHBRZQ==</auth>

2022-05-09 22:46:49 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0ySUlxOEdJM1ZaNVNJYURVOHBRZWFmcXlSb09iMTZicmRxZVVZWlRMLHM9TnNqQnJaU0x0aElmbFE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0ySUlxOEdJM1ZaNVNJYURVOHBRZWFmcXlSb09iMTZicmRxZVVZWlRMLHM9TnNqQnJaU0x0aElmbFE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:49 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MklJcThHSTNWWjVTSWFEVThwUWVhZnF5Um9PYjE2YnJkcWVVWVpUTCxwPWFUcWIzVVNFRTVRQnN1M3A4T2kzUUlYMVlTV2VyclI1K2tNL2lncERNMkU9</response>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MklJcThHSTNWWjVTSWFEVThwUWVhZnF5Um9PYjE2YnJkcWVVWVpUTCxwPWFUcWIzVVNFRTVRQnN1M3A4T2kzUUlYMVlTV2VyclI1K2tNL2lncERNMkU9</response>

2022-05-09 22:46:49 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zdGxha2tmVjNON0VlWDZWRHdsRnFOVkhQQjA1bUVZeG5hQldLNW9QWDJrPQ==</success>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zdGxha2tmVjNON0VlWDZWRHdsRnFOVkhQQjA1bUVZeG5hQldLNW9QWDJrPQ==</success>

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:49 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:49 |  << <iq xmlns="jabber:client" id="yJdakKKY6hNCjKxpcRQ9k9z" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com >> <iq xmlns="jabber:client" id="yJdakKKY6hNCjKxpcRQ9k9z" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:49 |  >> <iq to="jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335" xmlns="jabber:client" id="yJdakKKY6hNCjKxpcRQ9k9z" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335</jid></bind></iq>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com << <iq to="jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335" xmlns="jabber:client" id="yJdakKKY6hNCjKxpcRQ9k9z" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335</jid></bind></iq>

2022-05-09 22:46:49 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:49 |  << <iq to="test-domain.com" id="1usyz8mYq05pQLEl1qjKXWn" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335 >> <iq to="test-domain.com" id="1usyz8mYq05pQLEl1qjKXWn" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:49 |  << <iq id="6EUziFzapWVbKX2x6HFGHMH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335 >> <iq id="6EUziFzapWVbKX2x6HFGHMH" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:49 | jaxmpp_ :: jaxmpp__4luoap0562@test-domain.com/2095355307-tigase-335 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-05-09 22:46:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]
testStateAfterConnectionFailureSocket 0.252s
2022-05-09 22:46:50 |

2022-05-09 22:46:50 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-05-09 22:46:50 | ------------------------------------

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing. Trying next.

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

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:50 |  >> <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-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@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-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4153] Start TLS

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

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Proceeding TLS

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Start handshake

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-05-09 22:46:50 |  >> <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-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@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-05-09 22:46:50 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2h3aHExZjA1NjMscj1jdmFDakc4TGpOdzB6NHNOaGhwSw==</auth>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2h3aHExZjA1NjMscj1jdmFDakc4TGpOdzB6NHNOaGhwSw==</auth>

2022-05-09 22:46:50 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jdmFDakc4TGpOdzB6NHNOaGhwS2llcU1pemwzeXlxWTRZdGlLV3NpLHM9WW5MbDJYSjAxOHFZRmc9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jdmFDakc4TGpOdzB6NHNOaGhwS2llcU1pemwzeXlxWTRZdGlLV3NpLHM9WW5MbDJYSjAxOHFZRmc9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:50 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3ZhQ2pHOExqTncwejRzTmhocEtpZXFNaXpsM3l5cVk0WXRpS1dzaSxwPXgzcnlIYzBqUENkNE5DK2paMXhDZGhINzk0eTJCSTF1S2Jyb2dDNTE5Qmc9</response>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y3ZhQ2pHOExqTncwejRzTmhocEtpZXFNaXpsM3l5cVk0WXRpS1dzaSxwPXgzcnlIYzBqUENkNE5DK2paMXhDZGhINzk0eTJCSTF1S2Jyb2dDNTE5Qmc9</response>

2022-05-09 22:46:50 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Sc1lacGpwZC9aTUlpby9pUTJKbUpnWHZielpRZzdIQkVMYmx0Y2UzM2tnPQ==</success>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Sc1lacGpwZC9aTUlpby9pUTJKbUpnWHZielpRZzdIQkVMYmx0Y2UzM2tnPQ==</success>

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:50 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

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

2022-05-09 22:46:50 |  << <iq xmlns="jabber:client" id="SJ1FFIzt0cGzdxrlGsaOMDv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com >> <iq xmlns="jabber:client" id="SJ1FFIzt0cGzdxrlGsaOMDv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="SJ1FFIzt0cGzdxrlGsaOMDv" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336</jid></bind></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com << <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="SJ1FFIzt0cGzdxrlGsaOMDv" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336</jid></bind></iq>

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:50 |  << <iq xmlns="jabber:client" id="YxphQTRP1v06soWX9kJAdLU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 >> <iq xmlns="jabber:client" id="YxphQTRP1v06soWX9kJAdLU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="YxphQTRP1v06soWX9kJAdLU" type="result"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 << <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="YxphQTRP1v06soWX9kJAdLU" type="result"/>

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 >> <iq to="test-domain.com" id="mL3JNY5v4kW5fBzBcueW29x" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:50 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:50 |  >> <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="b097dabc-4cbf-4db3-b92c-42ec2a870dab"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 << <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="b097dabc-4cbf-4db3-b92c-42ec2a870dab"/>

2022-05-09 22:46:50 |  << <iq id="cAunNVeVYpQbDCzwbHs6ubr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 >> <iq id="cAunNVeVYpQbDCzwbHs6ubr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" from="test-domain.com" xmlns="jabber:client" id="mL3JNY5v4kW5fBzBcueW29x" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 << <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" from="test-domain.com" xmlns="jabber:client" id="mL3JNY5v4kW5fBzBcueW29x" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11739/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push: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:ietf:params:xml:ns:xmpp-bind"/><feature var="urn:xmpp:extdisco:2"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

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

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="cAunNVeVYpQbDCzwbHs6ubr" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 << <iq to="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client" id="cAunNVeVYpQbDCzwbHs6ubr" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

2022-05-09 22:46:50 |  >> <presence to="jaxmpp__hwhq1f0563@test-domain.com" from="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336 << <presence to="jaxmpp__hwhq1f0563@test-domain.com" from="jaxmpp__hwhq1f0563@test-domain.com/2095355307-tigase-336" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Connector  state changed: disconnecting->disconnected

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Stream terminated

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testStateAfterConnectionFailureWebSocket 0.351s
2022-05-09 22:46:50 |

2022-05-09 22:46:50 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-05-09 22:46:50 | ------------------------------------

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

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

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-05-09 22:46:50 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzRwOHNkYTA1NjQscj1UWWc0SXkya1dXZTNHNnVnVjhiSg==</auth>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzRwOHNkYTA1NjQscj1UWWc0SXkya1dXZTNHNnVnVjhiSg==</auth>

2022-05-09 22:46:50 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UWWc0SXkya1dXZTNHNnVnVjhiSkQzU0NkeGxocHMxTkxxbDVkeDJsLHM9eDNWZkYzbGJjd3l2bEE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UWWc0SXkya1dXZTNHNnVnVjhiSkQzU0NkeGxocHMxTkxxbDVkeDJsLHM9eDNWZkYzbGJjd3l2bEE9PSxpPTQwOTY=</challenge>

2022-05-09 22:46:50 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFlnNEl5MmtXV2UzRzZ1Z1Y4YkpEM1NDZHhsaHBzMU5McWw1ZHgybCxwPU5mNTdzQzVCdCtwYVZwaWpBL1hPb2x3R3hpZDdGUWtEU1U4ZitlQm5JU0E9</response>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFlnNEl5MmtXV2UzRzZ1Z1Y4YkpEM1NDZHhsaHBzMU5McWw1ZHgybCxwPU5mNTdzQzVCdCtwYVZwaWpBL1hPb2x3R3hpZDdGUWtEU1U4ZitlQm5JU0E9</response>

2022-05-09 22:46:50 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rNTh3bC9salVPelBneG10ZFJsTlpleHBRTlBEb1l0TkN3R0RmekhDUm00PQ==</success>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rNTh3bC9salVPelBneG10ZFJsTlpleHBRTlBEb1l0TkN3R0RmekhDUm00PQ==</success>

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-05-09 22:46:50 |  >> <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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@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" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="AeQ24enJwNGVdhn7dgDbLVrKWUk="/></features>

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

2022-05-09 22:46:50 |  << <iq xmlns="jabber:client" id="BFBJW29x6hGp9GPM14DxqbK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com >> <iq xmlns="jabber:client" id="BFBJW29x6hGp9GPM14DxqbK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337" xmlns="jabber:client" id="BFBJW29x6hGp9GPM14DxqbK" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337</jid></bind></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com << <iq to="jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337" xmlns="jabber:client" id="BFBJW29x6hGp9GPM14DxqbK" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337</jid></bind></iq>

2022-05-09 22:46:50 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-05-09 22:46:50 |  << <iq xmlns="jabber:client" id="l5PcKP2dLAm0dv7BFkKKY6h" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 >> <iq xmlns="jabber:client" id="l5PcKP2dLAm0dv7BFkKKY6h" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-05-09 22:46:50 |  >> <iq to="jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337" xmlns="jabber:client" id="l5PcKP2dLAm0dv7BFkKKY6h" type="result"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 << <iq to="jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337" xmlns="jabber:client" id="l5PcKP2dLAm0dv7BFkKKY6h" type="result"/>

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 >> <iq to="test-domain.com" id="rWm3iSXZ5xx4eIUY1hAfChT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-05-09 22:46:50 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-05-09 22:46:50 |  << <iq id="rXn5m0dv7BFkKKY6hNCjKxp" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 >> <iq id="rXn5m0dv7BFkKKY6hNCjKxp" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-05-09 22:46:50 |  >> <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="e7abbccf-b9df-476f-9fa4-d8989eb5a323"/>

2022-05-09 22:46:50 | jaxmpp_ :: jaxmpp__4p8sda0564@test-domain.com/2095355307-tigase-337 << <enabled max="60" resume="true" location="21fb2cc9076b" xmlns="urn:xmpp:sm:3" id="e7abbccf-b9df-476f-9fa4-d8989eb5a323"/>

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

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

2022-05-09 22:46:50 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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