Generated by TestNG with ReportNG at 22:17 PDT on Saturday 09 July 2022
root@f9c07ffec79b / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 64.209s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.604s
2022-07-09 22:41:09 |

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

2022-07-09 22:41:09 | ------------------------------------

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

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

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

2022-07-09 22:41:09 |  >> <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-07-09 22:41:09 | jaxmpp_ :: jaxmpp__o41e300559@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-07-09 22:41:29 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

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

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

2022-07-09 22:41:29 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

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

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

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

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX280MWUzMDA1NTkscj1mQW05Z3F5a2dqQkswT1IySThDZQ==</auth>

2022-07-09 22:41:29 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mQW05Z3F5a2dqQkswT1IySThDZUtpWmxURWprVXRHdEh1THQwOHAzLHM9MzhxOVN5N1pNc2t0RkE9PSxpPTQwOTY=</challenge>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mQW05Z3F5a2dqQkswT1IySThDZUtpWmxURWprVXRHdEh1THQwOHAzLHM9MzhxOVN5N1pNc2t0RkE9PSxpPTQwOTY=</challenge>

2022-07-09 22:41:29 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkFtOWdxeWtnakJLME9SMkk4Q2VLaVpsVEVqa1V0R3RIdUx0MDhwMyxwPW1EOW15eGtMckZMRWJUdDhoZFVNbzI3MGNkVFlCRCt3QnJLbzk2TW9qS2c9</response>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZkFtOWdxeWtnakJLME9SMkk4Q2VLaVpsVEVqa1V0R3RIdUx0MDhwMyxwPW1EOW15eGtMckZMRWJUdDhoZFVNbzI3MGNkVFlCRCt3QnJLbzk2TW9qS2c9</response>

2022-07-09 22:41:29 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Dd1F4R21qMml6Z21UZVZpV2h5Q01HeDh0MWJkK3oyYmN1NjBhVDRPOWFJPQ==</success>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Dd1F4R21qMml6Z21UZVZpV2h5Q01HeDh0MWJkK3oyYmN1NjBhVDRPOWFJPQ==</success>

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

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

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

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

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

2022-07-09 22:41:29 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:41:29 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:41:29 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

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

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

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

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326" xmlns="jabber:client" id="NHqhRNAsUamZaHQ9ycq2rj0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326</jid></bind></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326" xmlns="jabber:client" id="NHqhRNAsUamZaHQ9ycq2rj0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326</jid></bind></iq>

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

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

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="RJsuYiCvcLYp4euaHP25maH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="qXeWfWlWYY8DHMzk6zeFCEu" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="qXeWfWlWYY8DHMzk6zeFCEu" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-07-09 22:41:29 |  << <iq id="v0fSMKR9GnWk18teSW1coV9" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327 >> <iq id="v0fSMKR9GnWk18teSW1coV9" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="rU1HQ9ycq2rj01eUbs7ws6l" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328</jid></bind></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="rU1HQ9ycq2rj01eUbs7ws6l" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328</jid></bind></iq>

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

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327 >> <iq to="test-domain.com" id="Y8BWlWYY8DHMzk6zeFCEu7o" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" from="test-domain.com" xmlns="jabber:client" id="RJsuYiCvcLYp4euaHP25maH" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" from="test-domain.com" xmlns="jabber:client" id="RJsuYiCvcLYp4euaHP25maH" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:29 |  << <iq id="ZeRtcu0cLXiBoePKHGMKDqQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-327 >> <iq id="ZeRtcu0cLXiBoePKHGMKDqQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

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

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

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="v0fSMKR9GnWk18teSW1coV9" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="v0fSMKR9GnWk18teSW1coV9" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 >> <iq to="test-domain.com" id="S5o4u0hKRaNQMAm5BAbyyt2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:29 |  << <iq id="0UPY8DHMzk6zeFCEu7oMHHt" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 >> <iq id="0UPY8DHMzk6zeFCEu7oMHHt" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" from="test-domain.com" xmlns="jabber:client" id="Y8BWlWYY8DHMzk6zeFCEu7o" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" from="test-domain.com" xmlns="jabber:client" id="Y8BWlWYY8DHMzk6zeFCEu7o" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:29 |  >> <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="ZeRtcu0cLXiBoePKHGMKDqQ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 << <iq to="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="ZeRtcu0cLXiBoePKHGMKDqQ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:29 |  >> <presence to="jaxmpp__o41e300559@test-domain.com" from="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 << <presence to="jaxmpp__o41e300559@test-domain.com" from="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

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

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

2022-07-09 22:41:29 |  >> <presence to="jaxmpp__o41e300559@test-domain.com" from="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:41:29 | jaxmpp_ :: jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328 << <presence to="jaxmpp__o41e300559@test-domain.com" from="jaxmpp__o41e300559@test-domain.com/1781077109-tigase-328" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

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

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

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

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

2022-07-09 22:41:29 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500
testStateAfterAuthTimeoutSocket 20.272s
2022-07-09 22:41:30 |

2022-07-09 22:41:30 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-07-09 22:41:30 | ------------------------------------

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

2022-07-09 22:41:30 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-07-09 22:41:30 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2022-07-09 22:41:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4099] Start TLS

2022-07-09 22:41:30 |  >> <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-07-09 22:41:30 | jaxmpp_ :: jaxmpp__pfwtqx0560@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-07-09 22:41:30 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-07-09 22:41:30 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-07-09 22:41:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4101] Proceeding TLS

2022-07-09 22:41:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4101] Start handshake

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

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

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4101] Connector  state changed: connected->disconnected

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4101] Stream terminated

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

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

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

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

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2022-07-09 22:41: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-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4099] Start TLS

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@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-07-09 22:41:50 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

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

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4106] Proceeding TLS

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4106] Start handshake

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

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

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

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

2022-07-09 22:41: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-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@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-07-09 22:41:50 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Bmd3RxeDA1NjAscj0zVndJMjk5eGVzb2l6TkFoNEw3Qg==</auth>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Bmd3RxeDA1NjAscj0zVndJMjk5eGVzb2l6TkFoNEw3Qg==</auth>

2022-07-09 22:41:50 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zVndJMjk5eGVzb2l6TkFoNEw3QlAxMkIwWG5NWkN5QUhheU8yMXAzLHM9Q0lDWVRPL3RjMW1SeFE9PSxpPTQwOTY=</challenge>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zVndJMjk5eGVzb2l6TkFoNEw3QlAxMkIwWG5NWkN5QUhheU8yMXAzLHM9Q0lDWVRPL3RjMW1SeFE9PSxpPTQwOTY=</challenge>

2022-07-09 22:41:50 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M1Z3STI5OXhlc29pek5BaDRMN0JQMTJCMFhuTVpDeUFIYXlPMjFwMyxwPU43QURLZ1NUUWMvSjcyUHROSmdEaWdlYXk5RW1INnRYQ0xkdXQ4WUp5c3c9</response>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M1Z3STI5OXhlc29pek5BaDRMN0JQMTJCMFhuTVpDeUFIYXlPMjFwMyxwPU43QURLZ1NUUWMvSjcyUHROSmdEaWdlYXk5RW1INnRYQ0xkdXQ4WUp5c3c9</response>

2022-07-09 22:41:50 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16VitBYVFrMW5rekxubXBDQWoxb2hHVCt0aXp4cG41WS90VnRNK2RIZDRRPQ==</success>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16VitBYVFrMW5rekxubXBDQWoxb2hHVCt0aXp4cG41WS90VnRNK2RIZDRRPQ==</success>

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

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

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

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

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

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

2022-07-09 22:41:50 |  << <iq xmlns="jabber:client" id="74b6zeFCEu7oMHHtWak02lS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com >> <iq xmlns="jabber:client" id="74b6zeFCEu7oMHHtWak02lS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329" xmlns="jabber:client" id="74b6zeFCEu7oMHHtWak02lS" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329</jid></bind></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329" xmlns="jabber:client" id="74b6zeFCEu7oMHHtWak02lS" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329</jid></bind></iq>

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

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

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

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="kYR0iAw4p0ncRY26o9JQHAC" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330</jid></bind></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="kYR0iAw4p0ncRY26o9JQHAC" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330</jid></bind></iq>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="Pezv0iAw4p0ncRY26o9JQHA" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

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

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330 >> <iq xmlns="jabber:client" id="UiJMPQ3yzoSMKR9GnWk18te" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="qbso9KXaqSWfVet8INGzqgI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331</jid></bind></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="qbso9KXaqSWfVet8INGzqgI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331</jid></bind></iq>

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

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq xmlns="jabber:client" id="k2V8y6y8xgTeV6iCqdR6dCG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="Pezv0iAw4p0ncRY26o9JQHA" type="result"/>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="Pezv0iAw4p0ncRY26o9JQHA" type="result"/>

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

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="ur6KAcAxvoNM0nQT4yiJCeB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="UiJMPQ3yzoSMKR9GnWk18te" type="result"/>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="UiJMPQ3yzoSMKR9GnWk18te" type="result"/>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:41:50 |  >> <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="f686e8aa-3098-4c6a-8e3e-7b59c565262e" location="f9c07ffec79b"/>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="f686e8aa-3098-4c6a-8e3e-7b59c565262e" location="f9c07ffec79b"/>

2022-07-09 22:41:50 |  << <iq id="M9cGvjHo48CgNMVi3mOEul7" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq id="M9cGvjHo48CgNMVi3mOEul7" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="k2V8y6y8xgTeV6iCqdR6dCG" type="result"/>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="k2V8y6y8xgTeV6iCqdR6dCG" type="result"/>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="SiBukGDsh0tcu0cLXiBoePK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" from="test-domain.com" xmlns="jabber:client" id="ur6KAcAxvoNM0nQT4yiJCeB" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" from="test-domain.com" xmlns="jabber:client" id="ur6KAcAxvoNM0nQT4yiJCeB" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:50 |  << <iq id="IjDX6lQGvjHo48CgNMVi3mO" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq id="IjDX6lQGvjHo48CgNMVi3mO" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="M9cGvjHo48CgNMVi3mOEul7" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="M9cGvjHo48CgNMVi3mOEul7" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="DemrfAn2uat6cxnPEAaGo3i" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:41:50 |  << <iq id="UpR1jOZqjSQICBDEjO4v6p6" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <iq id="UpR1jOZqjSQICBDEjO4v6p6" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" from="test-domain.com" xmlns="jabber:client" id="SiBukGDsh0tcu0cLXiBoePK" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" from="test-domain.com" xmlns="jabber:client" id="SiBukGDsh0tcu0cLXiBoePK" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

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

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

2022-07-09 22:41:50 |  >> <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="IjDX6lQGvjHo48CgNMVi3mO" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="IjDX6lQGvjHo48CgNMVi3mO" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:41:50 |  >> <presence to="jaxmpp__pfwtqx0560@test-domain.com" from="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:41:50 | jaxmpp_ :: jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331 << <presence to="jaxmpp__pfwtqx0560@test-domain.com" from="jaxmpp__pfwtqx0560@test-domain.com/1781077109-tigase-331" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4106] Connector  state changed: disconnecting->disconnected

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4106] Stream terminated

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

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

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

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

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testStateAfterAuthTimeoutWebSocket 20.378s
2022-07-09 22:41:50 |

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

2022-07-09 22:41:50 | ------------------------------------

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

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

2022-07-09 22:41:50 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

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

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

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

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

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

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

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

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

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

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2022-07-09 22:42:10 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

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

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

2022-07-09 22:42:10 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-07-09 22:42:10 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-07-09 22:42:10 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

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

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

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

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

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2FvbnE4MTA1NjEscj1jQ2R5WnV1Y3hObkZUTnlHQ0hKeA==</auth>

2022-07-09 22:42:10 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jQ2R5WnV1Y3hObkZUTnlHQ0hKeEUydWlVVlhWeWsxNWJkcHdVZVpkLHM9YVBnMGFLWjZiWUtRbXc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jQ2R5WnV1Y3hObkZUTnlHQ0hKeEUydWlVVlhWeWsxNWJkcHdVZVpkLHM9YVBnMGFLWjZiWUtRbXc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:10 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y0NkeVp1dWN4Tm5GVE55R0NISnhFMnVpVVZYVnlrMTViZHB3VWVaZCxwPVR4WmRCWTF3UnNVaDZrY2NMZ3ZRZ2hRdzgvSUdsSkxENzNtQjgwcXN1VFk9</response>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y0NkeVp1dWN4Tm5GVE55R0NISnhFMnVpVVZYVnlrMTViZHB3VWVaZCxwPVR4WmRCWTF3UnNVaDZrY2NMZ3ZRZ2hRdzgvSUdsSkxENzNtQjgwcXN1VFk9</response>

2022-07-09 22:42:10 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1HbjRFZEFDZTdTWkNLNFB0THRZSlNrMHB0UHBzRTFPN0trVXhFTW45NWVnPQ==</success>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1HbjRFZEFDZTdTWkNLNFB0THRZSlNrMHB0UHBzRTFPN0trVXhFTW45NWVnPQ==</success>

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

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

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

2022-07-09 22:42:10 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:10 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:10 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

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

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

2022-07-09 22:42:10 |  << <iq xmlns="jabber:client" id="68Uh0nQT4yiJCeBv5aCeOEz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com >> <iq xmlns="jabber:client" id="68Uh0nQT4yiJCeBv5aCeOEz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

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

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

2022-07-09 22:42:10 |  << <iq xmlns="jabber:client" id="9w0nXcOOLGmR17eKukGDsh0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com >> <iq xmlns="jabber:client" id="9w0nXcOOLGmR17eKukGDsh0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-332" xmlns="jabber:client" id="68Uh0nQT4yiJCeBv5aCeOEz" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-332</jid></bind></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-332" xmlns="jabber:client" id="68Uh0nQT4yiJCeBv5aCeOEz" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-332</jid></bind></iq>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-333" xmlns="jabber:client" id="VaYuaHQ9ycq2rj01eUbs7ws" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-333</jid></bind></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-333" xmlns="jabber:client" id="VaYuaHQ9ycq2rj01eUbs7ws" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-333</jid></bind></iq>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="9w0nXcOOLGmR17eKukGDsh0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334</jid></bind></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="9w0nXcOOLGmR17eKukGDsh0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334</jid></bind></iq>

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

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

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

2022-07-09 22:42:10 |  << <iq xmlns="jabber:client" id="rmuCGPUUQS7FIr4Axaxm8s3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq xmlns="jabber:client" id="rmuCGPUUQS7FIr4Axaxm8s3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 |  << <iq xmlns="jabber:client" id="Mlp5jVVQYWeufGJUhOIs6zz" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq xmlns="jabber:client" id="Mlp5jVVQYWeufGJUhOIs6zz" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 |  << <iq xmlns="jabber:client" id="DowLTSXcOOLGmR17eKukGDs" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq xmlns="jabber:client" id="DowLTSXcOOLGmR17eKukGDs" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="rmuCGPUUQS7FIr4Axaxm8s3" type="result"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="rmuCGPUUQS7FIr4Axaxm8s3" type="result"/>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="Mlp5jVVQYWeufGJUhOIs6zz" type="result"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="Mlp5jVVQYWeufGJUhOIs6zz" type="result"/>

2022-07-09 22:42:10 |  >> <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="DowLTSXcOOLGmR17eKukGDs" type="result"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="DowLTSXcOOLGmR17eKukGDs" type="result"/>

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="DpxNX0dIQSTWST5fugwoOTY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:10 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="SwQXgynWfWlWYY8DHMzk6ze" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:10 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="2rzMZmJEKROPWiMHy6lZ36u" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:10 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:10 |  << <iq id="SyS1oOTYj4Bs02gTdODsm5g" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq id="SyS1oOTYj4Bs02gTdODsm5g" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:10 |  << <iq id="FE8DteSW1coV9nKMysW9ul8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq id="FE8DteSW1coV9nKMysW9ul8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:10 |  << <iq id="HvFTcAjMyfNFkWS6eJEFM1i" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <iq id="HvFTcAjMyfNFkWS6eJEFM1i" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-07-09 22:42:10 | jaxmpp_ :: jaxmpp__aonq810561@test-domain.com/1781077109-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

2022-07-09 22:42:10 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-07-09 22:42:10 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

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

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

2022-07-09 22:42:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testStateAfterConnectionFailureBosh 0.725s
2022-07-09 22:42:11 |

2022-07-09 22:42:11 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-07-09 22:42:11 | ------------------------------------

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

2022-07-09 22:42:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-07-09 22:42:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

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

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

2022-07-09 22:42:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

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

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

2022-07-09 22:42:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

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

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

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

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzUwc2dqMTA1NjIscj1xeTY0aFdkM0RMR0ZrQmNDakthWg==</auth>

2022-07-09 22:42:11 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xeTY0aFdkM0RMR0ZrQmNDakthWmlmSjZVU0hwT294UW1RV0hEUmZpLHM9d0lFd0I2ZHBTUmpMMWc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xeTY0aFdkM0RMR0ZrQmNDakthWmlmSjZVU0hwT294UW1RV0hEUmZpLHM9d0lFd0I2ZHBTUmpMMWc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:11 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cXk2NGhXZDNETEdGa0JjQ2pLYVppZko2VVNIcE9veFFtUVdIRFJmaSxwPVpsekJYQlhNdWNiK0R1Vnd0ck1MZzFLVjZXZGhzTW5xalVpK05DWDZJcUU9</response>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cXk2NGhXZDNETEdGa0JjQ2pLYVppZko2VVNIcE9veFFtUVdIRFJmaSxwPVpsekJYQlhNdWNiK0R1Vnd0ck1MZzFLVjZXZGhzTW5xalVpK05DWDZJcUU9</response>

2022-07-09 22:42:11 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WVGxoTHZYMWl0Q09ES3FQZHdlWUJ1Q2tXMXp1bHRCeTFIUm0wV3VQWmRrPQ==</success>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1WVGxoTHZYMWl0Q09ES3FQZHdlWUJ1Q2tXMXp1bHRCeTFIUm0wV3VQWmRrPQ==</success>

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

2022-07-09 22:42:11 |  << <iq xmlns="jabber:client" id="9JdNNSawbw2dJx4qQ26t8DI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com >> <iq xmlns="jabber:client" id="9JdNNSawbw2dJx4qQ26t8DI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:11 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

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

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

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335 >> <iq to="test-domain.com" id="DzH7BiNSawbw2dJx4qQ26t8" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:11 |  >> <iq to="jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="9JdNNSawbw2dJx4qQ26t8DI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335</jid></bind></iq>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335 << <iq to="jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="9JdNNSawbw2dJx4qQ26t8DI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335</jid></bind></iq>

2022-07-09 22:42:11 |  << <iq id="XAI4ADw8iMVhWTYo9oZgW4h" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335 >> <iq id="XAI4ADw8iMVhWTYo9oZgW4h" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-07-09 22:42:11 |  >> <iq to="jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335" from="test-domain.com" xmlns="jabber:client" id="DzH7BiNSawbw2dJx4qQ26t8" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:42:11 | jaxmpp_ :: jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335 << <iq to="jaxmpp__50sgj10562@test-domain.com/1781077109-tigase-335" from="test-domain.com" xmlns="jabber:client" id="DzH7BiNSawbw2dJx4qQ26t8" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:42:11 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-07-09 22:42:11 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

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

2022-07-09 22:42:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]
testStateAfterConnectionFailureSocket 0.178s
2022-07-09 22:42:12 |

2022-07-09 22:42:12 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-07-09 22:42:12 | ------------------------------------

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

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

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

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

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

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

2022-07-09 22:42:12 |  >> <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-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@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-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Start TLS

2022-07-09 22:42:12 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Proceeding TLS

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Start handshake

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

2022-07-09 22:42:12 |  >> <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-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@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-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

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

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzd0eXM4ZjA1NjMscj1GVUdzaUJhZFFIeW5UdTFFb2tUaA==</auth>

2022-07-09 22:42:12 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GVUdzaUJhZFFIeW5UdTFFb2tUaHR4SmxIQWFoaGhqZ0FXWVkyeVg2LHM9UTF2UXNOa25rNWNxblE9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GVUdzaUJhZFFIeW5UdTFFb2tUaHR4SmxIQWFoaGhqZ0FXWVkyeVg2LHM9UTF2UXNOa25rNWNxblE9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:12 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RlVHc2lCYWRRSHluVHUxRW9rVGh0eEpsSEFhaGhoamdBV1lZMnlYNixwPXJMY2ZKTlBOUHFHcDRIMFpvZUE4aEN2K1J0UWI5czluV2pIR1cvQnRiMm89</response>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RlVHc2lCYWRRSHluVHUxRW9rVGh0eEpsSEFhaGhoamdBV1lZMnlYNixwPXJMY2ZKTlBOUHFHcDRIMFpvZUE4aEN2K1J0UWI5czluV2pIR1cvQnRiMm89</response>

2022-07-09 22:42:12 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ydUczVUZCMGlxNG40MUxqT0VORFp6SllUaFFlNm5mM3RaeG1qNDFvK1V3PQ==</success>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ydUczVUZCMGlxNG40MUxqT0VORFp6SllUaFFlNm5mM3RaeG1qNDFvK1V3PQ==</success>

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

2022-07-09 22:42:12 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-07-09 22:42:12 |  << <iq xmlns="jabber:client" id="7EMhVW5skQPOCn3bm00mKLI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com >> <iq xmlns="jabber:client" id="7EMhVW5skQPOCn3bm00mKLI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="7EMhVW5skQPOCn3bm00mKLI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336</jid></bind></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com << <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="7EMhVW5skQPOCn3bm00mKLI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336</jid></bind></iq>

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

2022-07-09 22:42:12 |  << <iq xmlns="jabber:client" id="ltdZYiCvcLYp4euaHP25maH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 >> <iq xmlns="jabber:client" id="ltdZYiCvcLYp4euaHP25maH" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="ltdZYiCvcLYp4euaHP25maH" type="result"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="ltdZYiCvcLYp4euaHP25maH" type="result"/>

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 >> <iq to="test-domain.com" id="qL3zvsn06eEFLUPQ8DmV8Gy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:12 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:12 |  >> <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="bb156c21-fefc-4116-8234-dd06e330e085" location="f9c07ffec79b"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 << <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="bb156c21-fefc-4116-8234-dd06e330e085" location="f9c07ffec79b"/>

2022-07-09 22:42:12 |  << <iq id="Rvf36y8xgTeV6iCqdR6dCGJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 >> <iq id="Rvf36y8xgTeV6iCqdR6dCGJ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" from="test-domain.com" xmlns="jabber:client" id="qL3zvsn06eEFLUPQ8DmV8Gy" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" from="test-domain.com" xmlns="jabber:client" id="qL3zvsn06eEFLUPQ8DmV8Gy" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11900/eefdbe1f" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="list-multi" var="abuse-addresses"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="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:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="Rvf36y8xgTeV6iCqdR6dCGJ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="Rvf36y8xgTeV6iCqdR6dCGJ" type="result"><query xmlns="jabber:iq:roster"/></iq>

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

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

2022-07-09 22:42:12 |  >> <presence to="jaxmpp__7tys8f0563@test-domain.com" from="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336 << <presence to="jaxmpp__7tys8f0563@test-domain.com" from="jaxmpp__7tys8f0563@test-domain.com/1781077109-tigase-336" xmlns="jabber:client"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Connector  state changed: disconnecting->disconnected

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Stream terminated

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

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

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testStateAfterConnectionFailureWebSocket 0.350s
2022-07-09 22:42:12 |

2022-07-09 22:42:12 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-07-09 22:42:12 | ------------------------------------

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

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

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

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

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

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

2022-07-09 22:42:12 |  >> <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-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@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-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

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

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzkxYW5rZjA1NjQscj1nWWtWY2Q3M0FFNjlrVmdXZUtuSg==</auth>

2022-07-09 22:42:12 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nWWtWY2Q3M0FFNjlrVmdXZUtuSkZUS2U0aTVCcHJsdHd2b3VpODhpLHM9TGpDZW9FSll2bzFEaXc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nWWtWY2Q3M0FFNjlrVmdXZUtuSkZUS2U0aTVCcHJsdHd2b3VpODhpLHM9TGpDZW9FSll2bzFEaXc9PSxpPTQwOTY=</challenge>

2022-07-09 22:42:12 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1lrVmNkNzNBRTY5a1ZnV2VLbkpGVEtlNGk1QnBybHR3dm91aTg4aSxwPTN2ellZbGtlRlFPSjNiVVVsU2cwWHdqUXdRRklGZkFkbUlJd3FRQlQrUHM9</response>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1lrVmNkNzNBRTY5a1ZnV2VLbkpGVEtlNGk1QnBybHR3dm91aTg4aSxwPTN2ellZbGtlRlFPSjNiVVVsU2cwWHdqUXdRRklGZkFkbUlJd3FRQlQrUHM9</response>

2022-07-09 22:42:12 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1CRThNMm5MQzUvSVZCeWhiU1k2TWQ1alg4bXZtclRER2lxb0ROcmRjeGEwPQ==</success>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1CRThNMm5MQzUvSVZCeWhiU1k2TWQ1alg4bXZtclRER2lxb0ROcmRjeGEwPQ==</success>

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

2022-07-09 22:42:12 |  >> <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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@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" node="https://tigase.net/tigase-xmpp-server" ver="78MhZ3ywvj1Icse50Sj7wWpk/lU=" hash="SHA-1"/></features>

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

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

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

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337" xmlns="jabber:client" id="IRb3iJCeBv5aCeOEzk1ur8m" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337</jid></bind></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com << <iq to="jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337" xmlns="jabber:client" id="IRb3iJCeBv5aCeOEzk1ur8m" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337</jid></bind></iq>

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

2022-07-09 22:42:12 |  << <iq xmlns="jabber:client" id="t2G6s02gTdODsm5gJKU09sU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 >> <iq xmlns="jabber:client" id="t2G6s02gTdODsm5gJKU09sU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-07-09 22:42:12 |  >> <iq to="jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337" xmlns="jabber:client" id="t2G6s02gTdODsm5gJKU09sU" type="result"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 << <iq to="jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337" xmlns="jabber:client" id="t2G6s02gTdODsm5gJKU09sU" type="result"/>

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 >> <iq to="test-domain.com" id="vR7BeEFLUPQ8DmV8GyfEiJL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-07-09 22:42:12 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-07-09 22:42:12 |  << <iq id="LLN12dJx4qQ26t8DIT2amUb" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 >> <iq id="LLN12dJx4qQ26t8DIT2amUb" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-07-09 22:42:12 |  >> <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="07e993e3-9c45-4c0a-9707-4a962e9de481" location="f9c07ffec79b"/>

2022-07-09 22:42:12 | jaxmpp_ :: jaxmpp__91ankf0564@test-domain.com/1781077109-tigase-337 << <enabled max="60" resume="true" xmlns="urn:xmpp:sm:3" id="07e993e3-9c45-4c0a-9707-4a962e9de481" location="f9c07ffec79b"/>

2022-07-09 22:42:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-07-09 22:42:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

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

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