Generated by TestNG with ReportNG at 06:35 PDT on Friday 23 September 2022
root@ed1b7dd8a1b3 / Java 17.0.2 (Private Build) / Linux 4.14.281-212.502.amzn2.x86_64 (amd64)

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

Suites · Log Output

Test duration : 63.961s

Passed Tests
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues
testStateAfterAuthTimeoutBosh 20.662s
2022-09-23 06:58:33 |

2022-09-23 06:58:33 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:58:33 | ------------------------------------

2022-09-23 06:58:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:58:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:58:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-23 06:58:33 |  >> <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-23 06:58:33 | jaxmpp_ :: jaxmpp__8sriym0559@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-23 06:58:53 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-23 06:58:53 |  >> <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-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@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-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:58:53 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzhzcml5bTA1NTkscj16M2N3dlpwTEE0WVA4NkhrTGpjQw==</auth>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzhzcml5bTA1NTkscj16M2N3dlpwTEE0WVA4NkhrTGpjQw==</auth>

2022-09-23 06:58:53 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16M2N3dlpwTEE0WVA4NkhrTGpjQ09yV240Z1p1eFB2dGhLWEhYQVdZLHM9R3cxa3A5MkQxRVNJK2c9PSxpPTQwOTY=</challenge>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16M2N3dlpwTEE0WVA4NkhrTGpjQ09yV240Z1p1eFB2dGhLWEhYQVdZLHM9R3cxa3A5MkQxRVNJK2c9PSxpPTQwOTY=</challenge>

2022-09-23 06:58:53 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ejNjd3ZacExBNFlQODZIa0xqY0NPclduNGdadXhQdnRoS1hIWEFXWSxwPXhTM25DeHV0R2xUM29xU3VwTUcxTzI0eVdPQzZvemZnUEF2UE8xQUNaOG89</response>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ejNjd3ZacExBNFlQODZIa0xqY0NPclduNGdadXhQdnRoS1hIWEFXWSxwPXhTM25DeHV0R2xUM29xU3VwTUcxTzI0eVdPQzZvemZnUEF2UE8xQUNaOG89</response>

2022-09-23 06:58:53 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zZHdmeEo0bC9nQkJ0alBBVU5uOUpWSW5kVjVOaHk0TFhFdEU3eWZNNHNJPQ==</success>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zZHdmeEo0bC9nQkJ0alBBVU5uOUpWSW5kVjVOaHk0TFhFdEU3eWZNNHNJPQ==</success>

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:58:53 |  << <iq xmlns="jabber:client" id="5Xo6DgPRZ1xo5bu6oRXjP3y" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com >> <iq xmlns="jabber:client" id="5Xo6DgPRZ1xo5bu6oRXjP3y" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 |  << <iq xmlns="jabber:client" id="1MPnbHKwtWbzpRdKNBkMKzn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com >> <iq xmlns="jabber:client" id="1MPnbHKwtWbzpRdKNBkMKzn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 |  << <iq xmlns="jabber:client" id="QIBJRVfWaMYYiCygXl1oO36" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com >> <iq xmlns="jabber:client" id="QIBJRVfWaMYYiCygXl1oO36" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:58:53 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-325" id="1MPnbHKwtWbzpRdKNBkMKzn"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-325</jid></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-325" id="1MPnbHKwtWbzpRdKNBkMKzn"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-325</jid></bind></iq>

2022-09-23 06:58:53 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-326" id="QIBJRVfWaMYYiCygXl1oO36"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-326</jid></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-326" id="QIBJRVfWaMYYiCygXl1oO36"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-326</jid></bind></iq>

2022-09-23 06:58:53 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327" id="5Xo6DgPRZ1xo5bu6oRXjP3y"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327</jid></bind></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327" id="5Xo6DgPRZ1xo5bu6oRXjP3y"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327</jid></bind></iq>

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:58:53 |  << <iq to="test-domain.com" id="MFqgEu3l5n9KM0qS6eMIR9D" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq to="test-domain.com" id="MFqgEu3l5n9KM0qS6eMIR9D" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 |  << <iq to="test-domain.com" id="6HuHo5n15FEBdyeEnZnXj4q" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq to="test-domain.com" id="6HuHo5n15FEBdyeEnZnXj4q" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 |  << <iq to="test-domain.com" id="z7I3sWjCxhPHT6v1as6hNZb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq to="test-domain.com" id="z7I3sWjCxhPHT6v1as6hNZb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:58:53 |  << <iq id="Y7GGIseCFLR4aLwlT39NU7f" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq id="Y7GGIseCFLR4aLwlT39NU7f" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 |  << <iq id="A3sy8Ho5n15FEBdyeEnZnXj" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq id="A3sy8Ho5n15FEBdyeEnZnXj" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 |  << <iq id="EJsvdHrn4rTUW4dFJFJU6EI" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <iq id="EJsvdHrn4rTUW4dFJFJU6EI" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:58:53 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__8sriym0559@test-domain.com/1608752850-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

testStateAfterAuthTimeoutSocket 20.230s
2022-09-23 06:58:53 |

2022-09-23 06:58:53 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:58:53 | ------------------------------------

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: null->connecting

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222]

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector  state changed: connecting->connected

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:58:53 |  >> <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-23 06:58:53 | jaxmpp_ :: jaxmpp__ku8gqm0560@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-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4096] Start TLS

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4098] Proceeding TLS

2022-09-23 06:58:53 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:58:53 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:58:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4098] Start handshake

2022-09-23 06:58:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:58:54 |  >> <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-23 06:58:54 | jaxmpp_ :: jaxmpp__ku8gqm0560@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-23 06:58:54 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4098] Connector  state changed: connected->disconnected

2022-09-23 06:59:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4098] Stream terminated

2022-09-23 06:59:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: null->connecting

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: localhost:5222

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222]

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connecting->connected

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:14 |  >> <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-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@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-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4096] Start TLS

2022-09-23 06:59:14 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4103] Proceeding TLS

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4103] Start handshake

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:14 |  >> <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-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@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-23 06:59:14 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2t1OGdxbTA1NjAscj1KSURqeUZkVGp5V1lnajBoeTU5aQ==</auth>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2t1OGdxbTA1NjAscj1KSURqeUZkVGp5V1lnajBoeTU5aQ==</auth>

2022-09-23 06:59:14 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KSURqeUZkVGp5V1lnajBoeTU5aWNuRGp6ZllSRnVMRnpheVlJVWtlLHM9YkkxOGZXbE5manhEV3c9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KSURqeUZkVGp5V1lnajBoeTU5aWNuRGp6ZllSRnVMRnpheVlJVWtlLHM9YkkxOGZXbE5manhEV3c9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:14 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SklEanlGZFRqeVdZZ2owaHk1OWljbkRqemZZUkZ1TEZ6YXlZSVVrZSxwPXoydmNJbnB6WW8vd1UxTmluRTlDL2Z2OU9QWXFjbjVuSmdGdm85Rk9leDg9</response>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SklEanlGZFRqeVdZZ2owaHk1OWljbkRqemZZUkZ1TEZ6YXlZSVVrZSxwPXoydmNJbnB6WW8vd1UxTmluRTlDL2Z2OU9QWXFjbjVuSmdGdm85Rk9leDg9</response>

2022-09-23 06:59:14 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FR3ZJcCtOSHRnbUFYdWpPWWFIVEtrWTVEMW9FdDNhcXBhV3FpRkJ4VVNBPQ==</success>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FR3ZJcCtOSHRnbUFYdWpPWWFIVEtrWTVEMW9FdDNhcXBhV3FpRkJ4VVNBPQ==</success>

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="q5owsWeuiKVhT8i12nXbpjW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <iq xmlns="jabber:client" id="q5owsWeuiKVhT8i12nXbpjW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="IRG9Cx5iICjR7rh0i2u0mKO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <iq xmlns="jabber:client" id="IRG9Cx5iICjR7rh0i2u0mKO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328" id="q5owsWeuiKVhT8i12nXbpjW"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328</jid></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328" id="q5owsWeuiKVhT8i12nXbpjW"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328</jid></bind></iq>

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="kUN7Dtl8yyw4u0kO3xpam9i" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com >> <iq xmlns="jabber:client" id="kUN7Dtl8yyw4u0kO3xpam9i" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329" id="IRG9Cx5iICjR7rh0i2u0mKO"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329</jid></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329" id="IRG9Cx5iICjR7rh0i2u0mKO"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329</jid></bind></iq>

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="NYXkQLLV3vscQ6eOECodR3s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-328 >> <iq xmlns="jabber:client" id="NYXkQLLV3vscQ6eOECodR3s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="kUN7Dtl8yyw4u0kO3xpam9i"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330</jid></bind></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="kUN7Dtl8yyw4u0kO3xpam9i"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330</jid></bind></iq>

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="XjWAcKwmSbNVcqhyp1jFPYf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329 >> <iq xmlns="jabber:client" id="XjWAcKwmSbNVcqhyp1jFPYf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:14 |  << <iq xmlns="jabber:client" id="l7klTbOUgWUam2eTdLSMZYf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq xmlns="jabber:client" id="l7klTbOUgWUam2eTdLSMZYf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329" id="NYXkQLLV3vscQ6eOECodR3s"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-329" id="NYXkQLLV3vscQ6eOECodR3s"/>

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:14 |  << <iq to="test-domain.com" id="KdALxcwexj1fTeKWiCAcIAB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="KdALxcwexj1fTeKWiCAcIAB" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="XjWAcKwmSbNVcqhyp1jFPYf"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="XjWAcKwmSbNVcqhyp1jFPYf"/>

2022-09-23 06:59:14 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="l7klTbOUgWUam2eTdLSMZYf"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="l7klTbOUgWUam2eTdLSMZYf"/>

2022-09-23 06:59:14 |  << <iq id="SjQbLYeUeukGGwtn5w4z8zl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq id="SjQbLYeUeukGGwtn5w4z8zl" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 |  >> <enabled xmlns="urn:xmpp:sm:3" resume="true" id="a11eac79-7714-411c-b7f8-93dd6b468169" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <enabled xmlns="urn:xmpp:sm:3" resume="true" id="a11eac79-7714-411c-b7f8-93dd6b468169" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:14 |  << <iq to="test-domain.com" id="FezDx7JMRJAiMDvp1rkWk4a" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="FezDx7JMRJAiMDvp1rkWk4a" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:14 |  << <iq to="test-domain.com" id="7nYeLJJvvkXVY4kJHNNZq8I" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq to="test-domain.com" id="7nYeLJJvvkXVY4kJHNNZq8I" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

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

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

2022-09-23 06:59:14 |  << <iq id="k2Vn9vpgO4y8CgQQ7FFGodq" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq id="k2Vn9vpgO4y8CgQQ7FFGodq" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="SjQbLYeUeukGGwtn5w4z8zl"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="SjQbLYeUeukGGwtn5w4z8zl"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 |  << <iq id="Vq3GO26y8Ak5BxqSbm1fLzD" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <iq id="Vq3GO26y8Ak5BxqSbm1fLzD" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="k2Vn9vpgO4y8CgQQ7FFGodq"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="k2Vn9vpgO4y8CgQQ7FFGodq"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector  state changed: connected->disconnecting

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream

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

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

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

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

2022-09-23 06:59:14 |  >> <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="Vq3GO26y8Ak5BxqSbm1fLzD"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330" id="Vq3GO26y8Ak5BxqSbm1fLzD"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:14 |  >> <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 |  >> <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 | jaxmpp_ :: jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330 << <presence xmlns="jabber:client" to="jaxmpp__ku8gqm0560@test-domain.com" from="jaxmpp__ku8gqm0560@test-domain.com/1608752850-tigase-330"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4103] Connector  state changed: disconnecting->disconnected

testStateAfterAuthTimeoutWebSocket 20.352s
2022-09-23 06:59:14 |

2022-09-23 06:59:14 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:59:14 | ------------------------------------

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-09-23 06:59:14 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-09-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:14 |  >> <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-23 06:59:14 | jaxmpp_ :: jaxmpp__p9bnaj0561@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-23 06:59:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:34 |  >> <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-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@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-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:59:34 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A5Ym5hajA1NjEscj1oZU5RVzRncGpSbW1sNm1kWVlZcA==</auth>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A5Ym5hajA1NjEscj1oZU5RVzRncGpSbW1sNm1kWVlZcA==</auth>

2022-09-23 06:59:34 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oZU5RVzRncGpSbW1sNm1kWVlZcDBMSVlOU05zTmdQalg0ZmtJNzExLHM9Qm5FUWFibFJPYjZyeUE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oZU5RVzRncGpSbW1sNm1kWVlZcDBMSVlOU05zTmdQalg0ZmtJNzExLHM9Qm5FUWFibFJPYjZyeUE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:34 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aGVOUVc0Z3BqUm1tbDZtZFlZWXAwTElZTlNOc05nUGpYNGZrSTcxMSxwPU1UcDBnM0RhWlo0SEtUdDRuZmhsUzJGOGNGTEFiMEdMM2szb2JaT3ZHRFE9</response>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aGVOUVc0Z3BqUm1tbDZtZFlZWXAwTElZTlNOc05nUGpYNGZrSTcxMSxwPU1UcDBnM0RhWlo0SEtUdDRuZmhsUzJGOGNGTEFiMEdMM2szb2JaT3ZHRFE9</response>

2022-09-23 06:59:34 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RK2FGRm84ekpBbEo2NUZ2WWhXQmpYSGhpME5Tc0ZxK2pJbUZXQ0F0dmtNPQ==</success>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RK2FGRm84ekpBbEo2NUZ2WWhXQmpYSGhpME5Tc0ZxK2pJbUZXQ0F0dmtNPQ==</success>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

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

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="M3P3eEnZnXj4qi02qS4i1th" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com >> <iq xmlns="jabber:client" id="M3P3eEnZnXj4qi02qS4i1th" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="Q82Azl5CwuoOYYgGN1n6eTM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com >> <iq xmlns="jabber:client" id="Q82Azl5CwuoOYYgGN1n6eTM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="nhryyoeSMUQ0aLXfQIRIJFB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com >> <iq xmlns="jabber:client" id="nhryyoeSMUQ0aLXfQIRIJFB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-331" id="M3P3eEnZnXj4qi02qS4i1th"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-331</jid></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-331" id="M3P3eEnZnXj4qi02qS4i1th"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-331</jid></bind></iq>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-332" id="Q82Azl5CwuoOYYgGN1n6eTM"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-332</jid></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-332" id="Q82Azl5CwuoOYYgGN1n6eTM"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-332</jid></bind></iq>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="nhryyoeSMUQ0aLXfQIRIJFB"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333</jid></bind></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="nhryyoeSMUQ0aLXfQIRIJFB"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333</jid></bind></iq>

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="pxbVi02qS4i1thUQ7eLJJvv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="pxbVi02qS4i1thUQ7eLJJvv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="g7Tbuap3vdP6uqgysWcyxvl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="g7Tbuap3vdP6uqgysWcyxvl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 |  << <iq xmlns="jabber:client" id="Yx7xqS4i1thUQ7eLJJvvkXV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq xmlns="jabber:client" id="Yx7xqS4i1thUQ7eLJJvvkXV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="pxbVi02qS4i1thUQ7eLJJvv"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="pxbVi02qS4i1thUQ7eLJJvv"/>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="g7Tbuap3vdP6uqgysWcyxvl"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="g7Tbuap3vdP6uqgysWcyxvl"/>

2022-09-23 06:59:34 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="Yx7xqS4i1thUQ7eLJJvvkXV"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 << <iq xmlns="jabber:client" type="result" to="jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333" id="Yx7xqS4i1thUQ7eLJJvvkXV"/>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:34 |  << <iq to="test-domain.com" id="M9VfCqV5zl5CwuoOYYgGN1n" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="M9VfCqV5zl5CwuoOYYgGN1n" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 |  << <iq to="test-domain.com" id="uvXdKEJT7AcPEBp5dVaDhGu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="uvXdKEJT7AcPEBp5dVaDhGu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 |  << <iq id="Uz7XcQ6eOECodR3sWjCxhPH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq id="Uz7XcQ6eOECodR3sWjCxhPH" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 |  << <iq id="3Ce4u0rS3jTP9Cx5iICjR7r" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq id="3Ce4u0rS3jTP9Cx5iICjR7r" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:34 |  << <iq to="test-domain.com" id="6e2Myp1jFPYfv8oY1hX7DII" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq to="test-domain.com" id="6e2Myp1jFPYfv8oY1hX7DII" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:34 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:34 |  << <iq id="Ppxq5zl5CwuoOYYgGN1n6eT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <iq id="Ppxq5zl5CwuoOYYgGN1n6eT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:34 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:34 |  >> <enabled xmlns="urn:xmpp:sm:3" resume="true" id="47f8a15b-dc1e-4154-8524-ef63de245192" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:34 | jaxmpp_ :: jaxmpp__p9bnaj0561@test-domain.com/1608752850-tigase-333 << <enabled xmlns="urn:xmpp:sm:3" resume="true" id="47f8a15b-dc1e-4154-8524-ef63de245192" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-23 06:59:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testStateAfterConnectionFailureBosh 0.702s
2022-09-23 06:59:34 |

2022-09-23 06:59:34 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:59:34 | ------------------------------------

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-23 06:59:34 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error

2022-09-23 06:59:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2022-09-23 06:59:35 |  >> <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-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@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-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:59:35 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Z3dWhubDA1NjIscj1Mek02U3VlOFI3UmpJODZBSEIwNQ==</auth>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3Z3dWhubDA1NjIscj1Mek02U3VlOFI3UmpJODZBSEIwNQ==</auth>

2022-09-23 06:59:35 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Mek02U3VlOFI3UmpJODZBSEIwNUR1NWdtckNlajhaTzVHZlBpaXV0LHM9azNIeG0zZ0QvZE9HYkE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Mek02U3VlOFI3UmpJODZBSEIwNUR1NWdtckNlajhaTzVHZlBpaXV0LHM9azNIeG0zZ0QvZE9HYkE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:35 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9THpNNlN1ZThSN1JqSTg2QUhCMDVEdTVnbXJDZWo4Wk81R2ZQaWl1dCxwPXBNTys3T0d0Z2ZNNGczZG1LcmxQendGWWpmZXN1TDdLWW1TOXpuMWptbWc9</response>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9THpNNlN1ZThSN1JqSTg2QUhCMDVEdTVnbXJDZWo4Wk81R2ZQaWl1dCxwPXBNTys3T0d0Z2ZNNGczZG1LcmxQendGWWpmZXN1TDdLWW1TOXpuMWptbWc9</response>

2022-09-23 06:59:35 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iSUtFZWFMeW9XMUxpZTBLcXFnVFB4SmNKM1o4V3JVaDIyZXFRMEo0bEprPQ==</success>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iSUtFZWFMeW9XMUxpZTBLcXFnVFB4SmNKM1o4V3JVaDIyZXFRMEo0bEprPQ==</success>

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:59:35 |  << <iq xmlns="jabber:client" id="5D5tnKNNRL1m13eAmNP3j1u" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com >> <iq xmlns="jabber:client" id="5D5tnKNNRL1m13eAmNP3j1u" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:35 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334" id="5D5tnKNNRL1m13eAmNP3j1u"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334</jid></bind></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334" id="5D5tnKNNRL1m13eAmNP3j1u"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334</jid></bind></iq>

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:35 |  << <iq to="test-domain.com" id="Zk8TOW2vrdMABcHBtZtgPFs" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334 >> <iq to="test-domain.com" id="Zk8TOW2vrdMABcHBtZtgPFs" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:35 |  << <iq id="vl9TWj3reupOV3nN5uhzgEu" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334 >> <iq id="vl9TWj3reupOV3nN5uhzgEu" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

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

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

2022-09-23 06:59:35 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334" id="vl9TWj3reupOV3nN5uhzgEu"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334 << <iq xmlns="jabber:client" type="result" to="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334" id="vl9TWj3reupOV3nN5uhzgEu"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 |  >> <presence xmlns="jabber:client" to="jaxmpp__vwuhnl0562@test-domain.com" from="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334 << <presence xmlns="jabber:client" to="jaxmpp__vwuhnl0562@test-domain.com" from="jaxmpp__vwuhnl0562@test-domain.com/1608752850-tigase-334"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

testStateAfterConnectionFailureSocket 0.227s
2022-09-23 06:59:35 |

2022-09-23 06:59:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:59:35 | ------------------------------------

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: null->connecting

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] DNS entry stored in session object: missing:5222

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222]

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing. Trying next.

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector  state changed: connecting->disconnected

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: null->connecting

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] DNS entry stored in session object: localhost:5222

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222]

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connecting->connected

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:35 |  >> <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-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@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-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4157] Start TLS

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Proceeding TLS

2022-09-23 06:59:35 |  << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Start handshake

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:35 |  >> <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-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@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-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:59:35 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzM2bDQwdzA1NjMscj15aVM0Z1Y1NklZMnFUNmxNZjJHUQ==</auth>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzM2bDQwdzA1NjMscj15aVM0Z1Y1NklZMnFUNmxNZjJHUQ==</auth>

2022-09-23 06:59:35 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15aVM0Z1Y1NklZMnFUNmxNZjJHUXhnTmkwMVZaVzdBUUZwdXhGcFR4LHM9c0c2MElpc1JiUllncEE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15aVM0Z1Y1NklZMnFUNmxNZjJHUXhnTmkwMVZaVzdBUUZwdXhGcFR4LHM9c0c2MElpc1JiUllncEE9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:35 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWlTNGdWNTZJWTJxVDZsTWYyR1F4Z05pMDFWWlc3QVFGcHV4RnBUeCxwPWI5aVVJc3k0OHVFNXlVZ3lmWG5rMVVEQWNEdWI2OG1yM293S2d1am0wNWc9</response>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWlTNGdWNTZJWTJxVDZsTWYyR1F4Z05pMDFWWlc3QVFGcHV4RnBUeCxwPWI5aVVJc3k0OHVFNXlVZ3lmWG5rMVVEQWNEdWI2OG1yM293S2d1am0wNWc9</response>

2022-09-23 06:59:35 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SZE9qcDkwZlk0eVIxSEtDTjBFL29UekRCR1dJRlR5QzZCbzZMZjVsVU9RPQ==</success>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1SZE9qcDkwZlk0eVIxSEtDTjBFL29UekRCR1dJRlR5QzZCbzZMZjVsVU9RPQ==</success>

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:35 |  << <iq xmlns="jabber:client" id="yOqyreupOV3nN5uhzgEu3l5" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com >> <iq xmlns="jabber:client" id="yOqyreupOV3nN5uhzgEu3l5" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:35 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="yOqyreupOV3nN5uhzgEu3l5"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335</jid></bind></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="yOqyreupOV3nN5uhzgEu3l5"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335</jid></bind></iq>

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:35 |  << <iq xmlns="jabber:client" id="crhkYfv8oY1hX7DIISam4aE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 >> <iq xmlns="jabber:client" id="crhkYfv8oY1hX7DIISam4aE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:35 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="crhkYfv8oY1hX7DIISam4aE"/>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 << <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="crhkYfv8oY1hX7DIISam4aE"/>

2022-09-23 06:59:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:35 |  << <iq to="test-domain.com" id="AKaXWjCxhPHT6v1as6hNZbL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 >> <iq to="test-domain.com" id="AKaXWjCxhPHT6v1as6hNZbL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:35 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:35 |  >> <enabled xmlns="urn:xmpp:sm:3" resume="true" id="5a2b4e4f-66fa-41ab-a77e-c8799cf3c99f" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 << <enabled xmlns="urn:xmpp:sm:3" resume="true" id="5a2b4e4f-66fa-41ab-a77e-c8799cf3c99f" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:35 |  << <iq id="8qaU1jFPYfv8oY1hX7DIISa" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 >> <iq id="8qaU1jFPYfv8oY1hX7DIISa" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

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

2022-09-23 06:59:35 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:35 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="8qaU1jFPYfv8oY1hX7DIISa"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 << <iq xmlns="jabber:client" type="result" to="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335" id="8qaU1jFPYfv8oY1hX7DIISa"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector  state changed: connected->disconnecting

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:35 |  >> <presence xmlns="jabber:client" to="jaxmpp__36l40w0563@test-domain.com" from="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:35 | jaxmpp_ :: jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335 << <presence xmlns="jabber:client" to="jaxmpp__36l40w0563@test-domain.com" from="jaxmpp__36l40w0563@test-domain.com/1608752850-tigase-335"><c xmlns="http://jabber.org/protocol/caps" hash="sha-1" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4161] Connector  state changed: disconnecting->disconnected

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

testStateAfterConnectionFailureWebSocket 0.287s
2022-09-23 06:59:36 |

2022-09-23 06:59:36 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues]

2022-09-23 06:59:36 | ------------------------------------

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session]

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2022-09-23 06:59:36 |  >> <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-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@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-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2022-09-23 06:59:36 |  << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2VhNXFqbzA1NjQscj1NRGxZdVg0SzdZSks4dzBzeHpWWA==</auth>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2VhNXFqbzA1NjQscj1NRGxZdVg0SzdZSks4dzBzeHpWWA==</auth>

2022-09-23 06:59:36 |  >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NRGxZdVg0SzdZSks4dzBzeHpWWDVOcEJOUnpLWGN6ZFVmU2xId0M1LHM9UVM2ZllielZHaFlxTXc9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NRGxZdVg0SzdZSks4dzBzeHpWWDVOcEJOUnpLWGN6ZFVmU2xId0M1LHM9UVM2ZllielZHaFlxTXc9PSxpPTQwOTY=</challenge>

2022-09-23 06:59:36 |  << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TURsWXVYNEs3WUpLOHcwc3h6Vlg1TnBCTlJ6S1hjemRVZlNsSHdDNSxwPUJXeFdUekEwRHp1MUdRdXAyK2l6cm44UUJCRzRJME9BeC80NXR0cDJqU2s9</response>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TURsWXVYNEs3WUpLOHcwc3h6Vlg1TnBCTlJ6S1hjemRVZlNsSHdDNSxwPUJXeFdUekEwRHp1MUdRdXAyK2l6cm44UUJCRzRJME9BeC80NXR0cDJqU2s9</response>

2022-09-23 06:59:36 |  >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OcGN2QjdYZFRpRmI3OCtYWTNROStmRUFwUzRERkJIZFhXeER3Z0IzSWo4PQ==</success>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OcGN2QjdYZFRpRmI3OCtYWTNROStmRUFwUzRERkJIZFhXeER3Z0IzSWo4PQ==</success>

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

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

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c xmlns="http://jabber.org/protocol/caps" hash="SHA-1" node="https://tigase.net/tigase-xmpp-server" ver="/ilVXufrEeBII90o6mWDVJ6Tn+Q="/></features>

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false

2022-09-23 06:59:36 |  << <iq xmlns="jabber:client" id="eOcYX2cAfJRVfWaMYYiCygX" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com >> <iq xmlns="jabber:client" id="eOcYX2cAfJRVfWaMYYiCygX" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2022-09-23 06:59:36 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="eOcYX2cAfJRVfWaMYYiCygX"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336</jid></bind></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com << <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="eOcYX2cAfJRVfWaMYYiCygX"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336</jid></bind></iq>

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2022-09-23 06:59:36 |  << <iq xmlns="jabber:client" id="pXBLYmKQIKEJT7AcPEBp5dV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 >> <iq xmlns="jabber:client" id="pXBLYmKQIKEJT7AcPEBp5dV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2022-09-23 06:59:36 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="pXBLYmKQIKEJT7AcPEBp5dV"/>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="pXBLYmKQIKEJT7AcPEBp5dV"/>

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2022-09-23 06:59:36 |  << <iq to="test-domain.com" id="7Xzp7r9lbGFlOKGr7Dtl8yy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 >> <iq to="test-domain.com" id="7Xzp7r9lbGFlOKGr7Dtl8yy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2022-09-23 06:59:36 |  << <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2022-09-23 06:59:36 |  << <iq id="CznsU7r9lbGFlOKGr7Dtl8y" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 >> <iq id="CznsU7r9lbGFlOKGr7Dtl8y" type="get"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:36 |  << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2022-09-23 06:59:36 |  >> <enabled xmlns="urn:xmpp:sm:3" resume="true" id="2a423513-87b5-4c1d-9d01-5ce8b80e7773" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 << <enabled xmlns="urn:xmpp:sm:3" resume="true" id="2a423513-87b5-4c1d-9d01-5ce8b80e7773" max="60" location="ed1b7dd8a1b3"/>

2022-09-23 06:59:36 |  >> <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="CznsU7r9lbGFlOKGr7Dtl8y"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:36 | jaxmpp_ :: jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336 << <iq xmlns="jabber:client" type="result" to="jaxmpp__ea5qjo0564@test-domain.com/1608752850-tigase-336" id="CznsU7r9lbGFlOKGr7Dtl8y"><query xmlns="jabber:iq:roster"/></iq>

2022-09-23 06:59:36 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2022-09-23 06:59:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2022-09-23 06:59:39 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted