Generated by TestNG with ReportNG at 22:20 PDT on Tuesday 20 September 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.113s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.493s
2022-09-20 22:43:58 |

2022-09-20 22:43:58 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-20 22:43:58 | ------------------------------------

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

2022-09-20 22:43:58 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-20 22:43:58 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-20 22:43:59 |  >> <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-09-20 22:43:59 | jaxmpp_ :: jaxmpp__blv9wz0559@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-09-20 22:44:18 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

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

2022-09-20 22:44:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

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

2022-09-20 22:44:19 |  >> <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-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-20 22:44:19 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2Jsdjl3ejA1NTkscj1XWmhPU3lkRXEzUG1QYW51VlIwMg==</auth>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2Jsdjl3ejA1NTkscj1XWmhPU3lkRXEzUG1QYW51VlIwMg==</auth>

2022-09-20 22:44:19 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XWmhPU3lkRXEzUG1QYW51VlIwMjhWQmJzU0J2TFNSdjZjc1NlNTlqLHM9RkNKSytOQkI5UHcyWGc9PSxpPTQwOTY=</challenge>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XWmhPU3lkRXEzUG1QYW51VlIwMjhWQmJzU0J2TFNSdjZjc1NlNTlqLHM9RkNKSytOQkI5UHcyWGc9PSxpPTQwOTY=</challenge>

2022-09-20 22:44:19 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1poT1N5ZEVxM1BtUGFudVZSMDI4VkJic1NCdkxTUnY2Y3NTZTU5aixwPVZDZDVWZytrVGJqemNtVmQ0L0drOUp1SmxWdEpVaFZtMmIyeXVod0cwMHc9</response>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1poT1N5ZEVxM1BtUGFudVZSMDI4VkJic1NCdkxTUnY2Y3NTZTU5aixwPVZDZDVWZytrVGJqemNtVmQ0L0drOUp1SmxWdEpVaFZtMmIyeXVod0cwMHc9</response>

2022-09-20 22:44:19 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1INHUvaUd5SjUwWTJrVDlwVE0razRRemZYR1ZzU0hFQ2VSZzBLM0gwcy9FPQ==</success>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1INHUvaUd5SjUwWTJrVDlwVE0razRRemZYR1ZzU0hFQ2VSZzBLM0gwcy9FPQ==</success>

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:19 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 |  << <iq xmlns="jabber:client" id="BWbYY27qZcpj37fzaMHKJHv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com >> <iq xmlns="jabber:client" id="BWbYY27qZcpj37fzaMHKJHv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:19 |  << <iq xmlns="jabber:client" id="vaPoav5o2oOIt8p25FLx5fw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com >> <iq xmlns="jabber:client" id="vaPoav5o2oOIt8p25FLx5fw" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 |  << <iq xmlns="jabber:client" id="uSVBEGx9wiUQMBoV49N137j" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com >> <iq xmlns="jabber:client" id="uSVBEGx9wiUQMBoV49N137j" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:19 |  >> <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326" type="result" id="BWbYY27qZcpj37fzaMHKJHv" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326</jid></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com << <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326" type="result" id="BWbYY27qZcpj37fzaMHKJHv" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326</jid></bind></iq>

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

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

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="TYbTTWVScyzAyhDueMAgzkN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:19 |  >> <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327" type="result" id="vaPoav5o2oOIt8p25FLx5fw" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327" type="result" id="vaPoav5o2oOIt8p25FLx5fw" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327</jid></bind></iq>

2022-09-20 22:44:19 |  << <iq id="DMzw5mRWThZZZ38IzudFr27" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327 >> <iq id="DMzw5mRWThZZZ38IzudFr27" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

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

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327 >> <iq to="test-domain.com" id="WVYhACofWgHtaAu06fGvetr" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:19 |  << <iq id="XPECGwvsiLBq6w4evcxiBHP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327 >> <iq id="XPECGwvsiLBq6w4evcxiBHP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 |  >> <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="uSVBEGx9wiUQMBoV49N137j" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328</jid></bind></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="uSVBEGx9wiUQMBoV49N137j" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328</jid></bind></iq>

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

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

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

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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-09-20 22:44:19 |  >> <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="DMzw5mRWThZZZ38IzudFr27" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="DMzw5mRWThZZZ38IzudFr27" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@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-09-20 22:44:19 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-20 22:44:19 |  << <iq to="test-domain.com" id="0fSq17saEkKxgFy7JTNBhAC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328 >> <iq to="test-domain.com" id="0fSq17saEkKxgFy7JTNBhAC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:19 |  >> <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="XPECGwvsiLBq6w4evcxiBHP" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328 << <iq to="jaxmpp__blv9wz0559@test-domain.com/1781077109-tigase-328" type="result" id="XPECGwvsiLBq6w4evcxiBHP" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.eventbus.ThreadSafeEventBus$2.run:

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza

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

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

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

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

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

testStateAfterAuthTimeoutSocket 20.232s
2022-09-20 22:44:19 |

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

2022-09-20 22:44:19 | ------------------------------------

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

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

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:19 |  >> <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-09-20 22:44:19 | jaxmpp_ :: jaxmpp__eax4ec0560@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-09-20 22:44:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4090] Start TLS

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4092] Proceeding TLS

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

2022-09-20 22:44:19 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-20 22:44:19 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4092] Start handshake

2022-09-20 22:44:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4092] Connector  state changed: connected->disconnected

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4092] Stream terminated

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

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

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

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

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

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

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

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

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

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:39 |  >> <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-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4090] Start TLS

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

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4097] Proceeding TLS

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4097] Start handshake

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:39 |  >> <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-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

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

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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-09-20 22:44:39 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2VheDRlYzA1NjAscj1UcVphanBxT3V6V0twS2FYN05sag==</auth>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2VheDRlYzA1NjAscj1UcVphanBxT3V6V0twS2FYN05sag==</auth>

2022-09-20 22:44:39 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UcVphanBxT3V6V0twS2FYN05salp1UWpEaVFSUXdQMHR6QlUzTUs5LHM9T2hZdUZHeUUrREVGemc9PSxpPTQwOTY=</challenge>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UcVphanBxT3V6V0twS2FYN05salp1UWpEaVFSUXdQMHR6QlUzTUs5LHM9T2hZdUZHeUUrREVGemc9PSxpPTQwOTY=</challenge>

2022-09-20 22:44:39 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHFaYWpwcU91eldLcEthWDdObGpadVFqRGlRUlF3UDB0ekJVM01LOSxwPThUUGRhdFM1R1U1QjZkNVpCa0E2ci94MlFhMXJ4K21nZjZTYjljNDIxc2s9</response>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHFaYWpwcU91eldLcEthWDdObGpadVFqRGlRUlF3UDB0ekJVM01LOSxwPThUUGRhdFM1R1U1QjZkNVpCa0E2ci94MlFhMXJ4K21nZjZTYjljNDIxc2s9</response>

2022-09-20 22:44:39 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VZlBrdEpKV2paaDRLNmthd1VFTEhxcGdFWnpialQxSFNBbng2Wkx3bFlZPQ==</success>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VZlBrdEpKV2paaDRLNmthd1VFTEhxcGdFWnpialQxSFNBbng2Wkx3bFlZPQ==</success>

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:39 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:39 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

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

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="YUH8qj4wdveIKw8jOLKvvrT" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <iq xmlns="jabber:client" id="YUH8qj4wdveIKw8jOLKvvrT" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 |  >> <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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

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

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="EZU9u7sVl7fv5cQP0fJziDi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <iq xmlns="jabber:client" id="EZU9u7sVl7fv5cQP0fJziDi" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-329" type="result" id="YUH8qj4wdveIKw8jOLKvvrT" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-329</jid></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-329" type="result" id="YUH8qj4wdveIKw8jOLKvvrT" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-329</jid></bind></iq>

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

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="jWJcxq5pV038IADIONFym26" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com >> <iq xmlns="jabber:client" id="jWJcxq5pV038IADIONFym26" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330" type="result" id="EZU9u7sVl7fv5cQP0fJziDi" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330</jid></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330" type="result" id="EZU9u7sVl7fv5cQP0fJziDi" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330</jid></bind></iq>

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="mhIX9pYZ0s4BEGx9wiUQMBo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330 >> <iq xmlns="jabber:client" id="mhIX9pYZ0s4BEGx9wiUQMBo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="jWJcxq5pV038IADIONFym26" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331</jid></bind></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="jWJcxq5pV038IADIONFym26" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331</jid></bind></iq>

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="ko1tiPTTWVScyzAyhDueMAg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq xmlns="jabber:client" id="ko1tiPTTWVScyzAyhDueMAg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="mhIX9pYZ0s4BEGx9wiUQMBo" xmlns="jabber:client"/>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="mhIX9pYZ0s4BEGx9wiUQMBo" xmlns="jabber:client"/>

2022-09-20 22:44:39 |  << <iq xmlns="jabber:client" id="Ibm1xv13boeBylVX4boeCHQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq xmlns="jabber:client" id="Ibm1xv13boeBylVX4boeCHQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

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

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="Qq3xq5pV038IADIONFym26i" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="ko1tiPTTWVScyzAyhDueMAg" xmlns="jabber:client"/>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="ko1tiPTTWVScyzAyhDueMAg" xmlns="jabber:client"/>

2022-09-20 22:44:39 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-20 22:44:39 |  >> <enabled id="1689dd77-69ed-4ea8-b546-fecadaf0507c" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <enabled id="1689dd77-69ed-4ea8-b546-fecadaf0507c" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

2022-09-20 22:44:39 |  << <iq id="p63y9k6mbO0br6seu4byfIr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq id="p63y9k6mbO0br6seu4byfIr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="Ibm1xv13boeBylVX4boeCHQ" xmlns="jabber:client"/>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="Ibm1xv13boeBylVX4boeCHQ" xmlns="jabber:client"/>

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

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="F3SeBqRdRJt14AjYbBjMBeU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:39 |  << <iq id="873q2dEj7FlHtYoVcDv7oPG" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq id="873q2dEj7FlHtYoVcDv7oPG" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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-09-20 22:44:39 |  << <iq to="test-domain.com" id="z71xkYY27qZcpj37fzaMHKJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq to="test-domain.com" id="z71xkYY27qZcpj37fzaMHKJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="p63y9k6mbO0br6seu4byfIr" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="p63y9k6mbO0br6seu4byfIr" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 |  << <iq id="fu6uZ38IzudFr27gY6FMW3b" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 >> <iq id="fu6uZ38IzudFr27gY6FMW3b" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@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-09-20 22:44:39 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

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

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

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

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="873q2dEj7FlHtYoVcDv7oPG" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="873q2dEj7FlHtYoVcDv7oPG" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

2022-09-20 22:44:39 |  >> <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="fu6uZ38IzudFr27gY6FMW3b" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:44:39 | jaxmpp_ :: jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__eax4ec0560@test-domain.com/1781077109-tigase-331" type="result" id="fu6uZ38IzudFr27gY6FMW3b" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4097] Connector  state changed: disconnecting->disconnected

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4097] Stream terminated

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-20 22:44:39 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

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

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-20 22:44:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterAuthTimeoutWebSocket 20.368s
2022-09-20 22:44:40 |

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

2022-09-20 22:44:40 | ------------------------------------

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

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

2022-09-20 22:44:40 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-20 22:44:40 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-09-20 22:44:40 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-09-20 22:44:40 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-09-20 22:44:40 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-09-20 22:44:40 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-09-20 22:44:40 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-09-20 22:44:40 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-20 22:44:40 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-20 22:44:40 |  >> <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-09-20 22:44:40 | jaxmpp_ :: jaxmpp__93emz00561@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-09-20 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-09-20 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-09-20 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

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

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

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

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

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

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

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

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

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

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tdXpxVG5SY2dqMjNtWTA5bEtwUDM5M293NFpMSzVuTldLVWVCbkdmLHM9MVQzYkdhakEwY1AwZ2c9PSxpPTQwOTY=</challenge>

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bXV6cVRuUmNnajIzbVkwOWxLcFAzOTNvdzRaTEs1bk5XS1VlQm5HZixwPUNDSGxUL0Q2NS9rTE1INFJMYi9MQ25xdWRrVjlmZ2piWjFoZWVWcjUrRVk9</response>

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1KOFNzYmM5NE94TUtFbEhRTEhOdzY0cTFpUGc5YzEzQkwrVnB5WlBTZEYwPQ==</success>

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-332" type="result" id="eCmqRJx6EreHDnURKW2xwq1" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__93emz00561@test-domain.com/1781077109-tigase-332</jid></bind></iq>

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

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-333" type="result" id="pfdRLyygZqeDlU4sWYZatal" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__93emz00561@test-domain.com/1781077109-tigase-333</jid></bind></iq>

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

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="0Bf9t1gMSMElST01xv13boe" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334</jid></bind></iq>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com << <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="0Bf9t1gMSMElST01xv13boe" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334</jid></bind></iq>

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-332 >> <iq xmlns="jabber:client" id="sc0JCHQ4jHCuiCkHAjQHTdr" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq xmlns="jabber:client" id="6vT5gzkNODLXVRNCGvmX9pY" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq xmlns="jabber:client" id="TrFQNKx6EsncMJxiQ02anW1" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="sc0JCHQ4jHCuiCkHAjQHTdr" xmlns="jabber:client"/>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="sc0JCHQ4jHCuiCkHAjQHTdr" xmlns="jabber:client"/>

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="6vT5gzkNODLXVRNCGvmX9pY" xmlns="jabber:client"/>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="6vT5gzkNODLXVRNCGvmX9pY" xmlns="jabber:client"/>

2022-09-20 22:45:00 |  >> <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="TrFQNKx6EsncMJxiQ02anW1" xmlns="jabber:client"/>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 << <iq to="jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334" type="result" id="TrFQNKx6EsncMJxiQ02anW1" xmlns="jabber:client"/>

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

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="youkS0kGsX6lUP9JtXZ0s3s" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="kGk4udFr27gY6FMW3bAqamO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="wHllRNOS4aqTY5oN5BdrXWk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq id="LHjUPJuqZkT19sXWkO5CCpT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:45:00 |  << <iq id="1FbOHCuiCkHAjQHTdrTRKW1" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq id="1FbOHCuiCkHAjQHTdrTRKW1" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:45:00 |  << <iq id="2tzucECgChKDuZtnLx9k6l2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 >> <iq id="2tzucECgChKDuZtnLx9k6l2" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@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-09-20 22:45:00 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@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-09-20 22:45:00 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@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-09-20 22:45:00 |  >> <enabled id="ce50c4cd-752f-4f5e-b305-10305e00d10d" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

2022-09-20 22:45:00 | jaxmpp_ :: jaxmpp__93emz00561@test-domain.com/1781077109-tigase-334 << <enabled id="ce50c4cd-752f-4f5e-b305-10305e00d10d" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

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

2022-09-20 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

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

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

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

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

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

testStateAfterConnectionFailureBosh 0.728s
2022-09-20 22:45:00 |

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

2022-09-20 22:45:00 | ------------------------------------

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

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

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-09-20 22:45:00 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

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

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

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

2022-09-20 22:45:00 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

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

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

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

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

2022-09-20 22:45:00 |  >> <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-09-20 22:45:00 | jaxmpp_ :: jaxmpp__9b7xm40562@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-09-20 22:45:01 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xMGhxVENpejVkeGtCRzhKbzJ4TVZzMW0wcVZ0bnR2cUdMRXVuTXZtLHM9WTdHa3FxQzhaV3pYbUE9PSxpPTQwOTY=</challenge>

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__9b7xm40562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xMGhxVENpejVkeGtCRzhKbzJ4TVZzMW0wcVZ0bnR2cUdMRXVuTXZtLHM9WTdHa3FxQzhaV3pYbUE9PSxpPTQwOTY=</challenge>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__9b7xm40562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cTBocVRDaXo1ZHhrQkc4Sm8yeE1WczFtMHFWdG50dnFHTEV1bk12bSxwPWNrUU9oaXRRNnBsdHFXbFMrR3JOVTk2RWJKdlcva2hMdVF1U0M2dzA2eW89</response>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__9b7xm40562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1NWjlCZkhiRm5zb0NGYzhEWGwxencyZlVGaXMxZnpQKzc3a0VZVjF5YTNnPQ==</success>

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

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

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

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

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

2022-09-20 22:45:01 |  >> <iq to="jaxmpp__9b7xm40562@test-domain.com/1781077109-tigase-335" type="result" id="fNp6dv2wbIFzfElISUh0oXZ" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9b7xm40562@test-domain.com/1781077109-tigase-335</jid></bind></iq>

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

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

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__9b7xm40562@test-domain.com/1781077109-tigase-335 >> <iq to="test-domain.com" id="8tp8s3kFP5bnPGOLSZdxev2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__9b7xm40562@test-domain.com/1781077109-tigase-335 >> <iq id="sqebwvsiLBq6w4evcxiBHPF" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2022-09-20 22:45:01 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-09-20 22:45:01 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

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

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

testStateAfterConnectionFailureSocket 0.192s
2022-09-20 22:45:01 |

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

2022-09-20 22:45:01 | ------------------------------------

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

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

2022-09-20 22:45:01 |  >> <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-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@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-09-20 22:45:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4149] Start TLS

2022-09-20 22:45:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4153] Proceeding TLS

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

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

2022-09-20 22:45:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4153] Start handshake

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

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

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

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

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

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

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nT2wzaXduQ3BldjZudjJ2M09hSFRRSXhEdjJzZldwQ21HWHJuMWR4LHM9RlpMVHFoenYwczI3aVE9PSxpPTQwOTY=</challenge>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z09sM2l3bkNwZXY2bnYydjNPYUhUUUl4RHYyc2ZXcENtR1hybjFkeCxwPVNxaWNmaTVKNTdzV2h0TlJaK0orY2tSTnliY3VKTFNDMTRtWXd4VFVJUkk9</response>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Sb3M3enNjZ1VwYklDODVIQ0thS1pBUzYzc1NiVS96L1VINXp3UkxwRXpRPQ==</success>

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

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

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

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

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

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

2022-09-20 22:45:01 |  >> <iq to="jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336" type="result" id="dtfgXVRNCGvmX9pYZ0s4BEG" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336</jid></bind></iq>

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

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

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 >> <iq xmlns="jabber:client" id="WDHIsmSdS8rX8wmKAdCnYXp" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:45:01 |  >> <iq to="jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336" type="result" id="WDHIsmSdS8rX8wmKAdCnYXp" xmlns="jabber:client"/>

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336" type="result" id="WDHIsmSdS8rX8wmKAdCnYXp" xmlns="jabber:client"/>

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

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 >> <iq to="test-domain.com" id="bDFPFP5bnPGOLSZdxev2wcR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

2022-09-20 22:45:01 |  >> <enabled id="93d4c521-1db4-4b30-a8b8-4e2e7354bd1a" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 << <enabled id="93d4c521-1db4-4b30-a8b8-4e2e7354bd1a" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 >> <iq id="e0KcpPJuqZkT19sXWkO5CCp" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@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-09-20 22:45:01 |  >> <iq to="jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336" type="result" id="e0KcpPJuqZkT19sXWkO5CCp" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2022-09-20 22:45:01 | jaxmpp_ :: jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__lbgjil0563@test-domain.com/1781077109-tigase-336" type="result" id="e0KcpPJuqZkT19sXWkO5CCp" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

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

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

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

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

2022-09-20 22:45:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4153] Connector  state changed: disconnecting->disconnected

2022-09-20 22:45:01 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4153] Stream terminated

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

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

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

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

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

testStateAfterConnectionFailureWebSocket 0.366s
2022-09-20 22:45:02 |

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

2022-09-20 22:45:02 | ------------------------------------

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

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

2022-09-20 22:45:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-20 22:45:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

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

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

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

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

2022-09-20 22:45:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-20 22:45:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

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

2022-09-20 22:45:02 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

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

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

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

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

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

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

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

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

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

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15TEFseVMzdDBXMmRIckJnVm8wUEV0U2psSkV0TlhEaEx0bHdpSWdQLHM9dGF0ejZhWFBOUHIrL2c9PSxpPTQwOTY=</challenge>

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eUxBbHlTM3QwVzJkSHJCZ1ZvMFBFdFNqbEpFdE5YRGhMdGx3aUlnUCxwPVQ5WENzM2cvQWJmTExtTWNJNWRKeHRkSmU2Y3RIb0FzUmo1Rit1REtrL2s9</response>

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16c0xHOE01Q1l6b1JVcTZIUG11S3lJY2NYTWt0b0laeEN5clBkeXRBNStzPQ==</success>

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

2022-09-20 22:45:02 |  >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><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 ver="zCEFhSmX6YrSUHuZ1Yz3X89kRtA=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

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

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

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

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

2022-09-20 22:45:02 |  >> <iq to="jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337" type="result" id="w1FZ9nYcIs03iJGnfVRJx6E" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337</jid></bind></iq>

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

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

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337 >> <iq xmlns="jabber:client" id="v3JbKFp2kYY27qZcpj37fza" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-20 22:45:02 |  >> <iq to="jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337" type="result" id="v3JbKFp2kYY27qZcpj37fza" xmlns="jabber:client"/>

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337 << <iq to="jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337" type="result" id="v3JbKFp2kYY27qZcpj37fza" xmlns="jabber:client"/>

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

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337 >> <iq to="test-domain.com" id="TQ4EpYZ0s4BEGx9wiUQMBoV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337 >> <iq id="e7RqRJx6EreHDnURKW2xwq1" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@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-09-20 22:45:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-09-20 22:45:02 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-09-20 22:45:02 |  >> <enabled id="58f10a7e-35ba-499b-aa31-6a54aaebc320" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

2022-09-20 22:45:02 | jaxmpp_ :: jaxmpp__do4dee0564@test-domain.com/1781077109-tigase-337 << <enabled id="58f10a7e-35ba-499b-aa31-6a54aaebc320" resume="true" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/>

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

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

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

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