Test duration : 64.316s
Passed Tests | ||
---|---|---|
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
testStateAfterAuthTimeoutBosh | 20.496s |
2022-08-07 22:42:32 |
2022-08-07 22:42:32 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:42:32 | ------------------------------------ 2022-08-07 22:42:32 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:42:32 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:42:32 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-07 22:42:32 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:32 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-07 22:42:52 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:42:52 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3RnZnVpejA1NTkscj1QRUdoQldCSDN2NGNJZVdaMkUwbQ==</auth> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3RnZnVpejA1NTkscj1QRUdoQldCSDN2NGNJZVdaMkUwbQ==</auth> 2022-08-07 22:42:52 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QRUdoQldCSDN2NGNJZVdaMkUwbVRySk83WEl1TThzVmFER25uMjZTLHM9ZDdJMDJVRnEvODZoV0E9PSxpPTQwOTY=</challenge> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QRUdoQldCSDN2NGNJZVdaMkUwbVRySk83WEl1TThzVmFER25uMjZTLHM9ZDdJMDJVRnEvODZoV0E9PSxpPTQwOTY=</challenge> 2022-08-07 22:42:52 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UEVHaEJXQkgzdjRjSWVXWjJFMG1UckpPN1hJdU04c1ZhREdubjI2UyxwPTFldVNkcGVXYVdDVUZkNVlKWnFnb2ZIb21namNmaEl0dWhTMlVLTk9xTDg9</response> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UEVHaEJXQkgzdjRjSWVXWjJFMG1UckpPN1hJdU04c1ZhREdubjI2UyxwPTFldVNkcGVXYVdDVUZkNVlKWnFnb2ZIb21namNmaEl0dWhTMlVLTk9xTDg9</response> 2022-08-07 22:42:52 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00Ym5iUEw0V0NGN0JxSUphdG1SaUJOcWY2Mko3Rm43cFpCdG05UTQ5WTIwPQ==</success> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00Ym5iUEw0V0NGN0JxSUphdG1SaUJOcWY2Mko3Rm43cFpCdG05UTQ5WTIwPQ==</success> 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:42:52 | << <iq xmlns="jabber:client" id="A0xBzqSOYZsnKCwbqQaHTW0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com >> <iq xmlns="jabber:client" id="A0xBzqSOYZsnKCwbqQaHTW0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | << <iq xmlns="jabber:client" id="qDoq2bIKJymUdFHGoQ27ITM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com >> <iq xmlns="jabber:client" id="qDoq2bIKJymUdFHGoQ27ITM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | << <iq xmlns="jabber:client" id="oLK8hU07AudwiMX9FCgAw5E" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com >> <iq xmlns="jabber:client" id="oLK8hU07AudwiMX9FCgAw5E" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:42:52 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325" xmlns="jabber:client" id="A0xBzqSOYZsnKCwbqQaHTW0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325</jid></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325" xmlns="jabber:client" id="A0xBzqSOYZsnKCwbqQaHTW0" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325</jid></bind></iq> 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:42:52 | << <iq to="test-domain.com" id="G0rdUhyeKDkEMVlQOYXgIxq" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325 >> <iq to="test-domain.com" id="G0rdUhyeKDkEMVlQOYXgIxq" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | << <iq id="WGrwezuiPKKGLLT4ao8j6Fk" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325 >> <iq id="WGrwezuiPKKGLLT4ao8j6Fk" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-325 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:42:52 | << <iq to="test-domain.com" id="TQTcKvmUVcIFq6obBzqSOYZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326 >> <iq to="test-domain.com" id="TQTcKvmUVcIFq6obBzqSOYZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326" xmlns="jabber:client" id="qDoq2bIKJymUdFHGoQ27ITM" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326</jid></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326" xmlns="jabber:client" id="qDoq2bIKJymUdFHGoQ27ITM" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326</jid></bind></iq> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="oLK8hU07AudwiMX9FCgAw5E" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327</jid></bind></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-326 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="oLK8hU07AudwiMX9FCgAw5E" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327</jid></bind></iq> 2022-08-07 22:42:52 | << <iq id="LPOcx8g0nfEqcpaw9ECt2kQ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 >> <iq id="LPOcx8g0nfEqcpaw9ECt2kQ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:42:52 | << <iq to="test-domain.com" id="hRS6cS7JCm49Eu5wmX0gIPT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 >> <iq to="test-domain.com" id="hRS6cS7JCm49Eu5wmX0gIPT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="G0rdUhyeKDkEMVlQOYXgIxq" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="G0rdUhyeKDkEMVlQOYXgIxq" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:42:52 | << <iq id="yZeWhNXcqUaneVQOUXYWm5F" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 >> <iq id="yZeWhNXcqUaneVQOUXYWm5F" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="WGrwezuiPKKGLLT4ao8j6Fk" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="WGrwezuiPKKGLLT4ao8j6Fk" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:42:52 | >> <presence to="jaxmpp__tgfuiz0559@test-domain.com" xmlns="jabber:client" from="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 << <presence to="jaxmpp__tgfuiz0559@test-domain.com" xmlns="jabber:client" from="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="TQTcKvmUVcIFq6obBzqSOYZ" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="TQTcKvmUVcIFq6obBzqSOYZ" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:42:52 | >> <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="LPOcx8g0nfEqcpaw9ECt2kQ" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | jaxmpp_ :: jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327 << <iq to="jaxmpp__tgfuiz0559@test-domain.com/1781077109-tigase-327" xmlns="jabber:client" id="LPOcx8g0nfEqcpaw9ECt2kQ" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-07 22:42:52 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2022-08-07 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
testStateAfterAuthTimeoutSocket | 20.295s |
2022-08-07 22:42:53 |
2022-08-07 22:42:53 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:42:53 | ------------------------------------ 2022-08-07 22:42:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: null->connecting 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222] 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: connecting->connected 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms 2022-08-07 22:42:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:42: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-08-07 22:42:53 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4083] Start TLS 2022-08-07 22:42:53 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:42:53 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4085] Proceeding TLS 2022-08-07 22:42:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4085] Start handshake 2022-08-07 22:42:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:42: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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:53 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:42:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4085] Connector state changed: connected->disconnected 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4085] Stream terminated 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: null->connecting 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: localhost:5222 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222] 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connecting->connected 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4083] Start TLS 2022-08-07 22:43:13 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4090] Proceeding TLS 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4090] Start handshake 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:43:13 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2NmdWdsMDU2MCxyPXA2aHU2WDZDWmtvdUpiQjNRRUZC</auth> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2NmdWdsMDU2MCxyPXA2aHU2WDZDWmtvdUpiQjNRRUZC</auth> 2022-08-07 22:43:13 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wNmh1Nlg2Q1prb3VKYkIzUUVGQkE4M3JDRDFWeUZhSUlZVnl1MlVFLHM9cEN4VjVBOS8xV21xcWc9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wNmh1Nlg2Q1prb3VKYkIzUUVGQkE4M3JDRDFWeUZhSUlZVnl1MlVFLHM9cEN4VjVBOS8xV21xcWc9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:13 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDZodTZYNkNaa291SmJCM1FFRkJBODNyQ0QxVnlGYUlJWVZ5dTJVRSxwPUM5WGhwUGtFY2lFVXFJbU9xUVRSZVEweStScHBGclV0dzQ3UkRRUHR2Y2M9</response> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDZodTZYNkNaa291SmJCM1FFRkJBODNyQ0QxVnlGYUlJWVZ5dTJVRSxwPUM5WGhwUGtFY2lFVXFJbU9xUVRSZVEweStScHBGclV0dzQ3UkRRUHR2Y2M9</response> 2022-08-07 22:43:13 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13SDRYMDBiK1N6SGxVN2gzMVU3c1JHYWFUaTUwdGJUVnhKdzkzektpUEUwPQ==</success> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13SDRYMDBiK1N6SGxVN2gzMVU3c1JHYWFUaTUwdGJUVnhKdzkzektpUEUwPQ==</success> 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="M5oduYqdV08CfQSR4s9o2gV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <iq xmlns="jabber:client" id="M5oduYqdV08CfQSR4s9o2gV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="OSJKYj7oUal2gDCylMOO1hV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <iq xmlns="jabber:client" id="OSJKYj7oUal2gDCylMOO1hV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="bSHaNAiSTQGQ3BmQ25wezui" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com >> <iq xmlns="jabber:client" id="bSHaNAiSTQGQ3BmQ25wezui" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="M5oduYqdV08CfQSR4s9o2gV" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-328</jid></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-328" xmlns="jabber:client" id="M5oduYqdV08CfQSR4s9o2gV" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-328</jid></bind></iq> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329" xmlns="jabber:client" id="OSJKYj7oUal2gDCylMOO1hV" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329</jid></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-328 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329" xmlns="jabber:client" id="OSJKYj7oUal2gDCylMOO1hV" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329</jid></bind></iq> 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="OULO6zDqYiByiHKOROSWhNX" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="OULO6zDqYiByiHKOROSWhNX" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="bSHaNAiSTQGQ3BmQ25wezui" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330</jid></bind></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="bSHaNAiSTQGQ3BmQ25wezui" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330</jid></bind></iq> 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="HUJeVQOUXYWm5Fu6y7AmP0k" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="HUJeVQOUXYWm5Fu6y7AmP0k" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:13 | << <iq xmlns="jabber:client" id="DatgAw5ELwaCnOCIN5kMUP0" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq xmlns="jabber:client" id="DatgAw5ELwaCnOCIN5kMUP0" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="OULO6zDqYiByiHKOROSWhNX" type="result"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="OULO6zDqYiByiHKOROSWhNX" type="result"/> 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-07 22:43:13 | << <iq to="test-domain.com" id="kn4N5kMUP0cvm2jIGyvfR02" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="kn4N5kMUP0cvm2jIGyvfR02" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:13 | >> <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="94be9be3-c6c3-4a52-be43-458b753a46ac"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="94be9be3-c6c3-4a52-be43-458b753a46ac"/> 2022-08-07 22:43:13 | << <iq id="ChK4ao8j6FkMQPIqk1xeAw3" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq id="ChK4ao8j6FkMQPIqk1xeAw3" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="HUJeVQOUXYWm5Fu6y7AmP0k" type="result"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="HUJeVQOUXYWm5Fu6y7AmP0k" type="result"/> 2022-08-07 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="DatgAw5ELwaCnOCIN5kMUP0" type="result"/> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="DatgAw5ELwaCnOCIN5kMUP0" type="result"/> 2022-08-07 22:43:13 | << <iq to="test-domain.com" id="Sq9KCAbICl2o18weRXhQIuk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="Sq9KCAbICl2o18weRXhQIuk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | << <iq id="piJLSWZkYbsawr7Bu04u1wv" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq id="piJLSWZkYbsawr7Bu04u1wv" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | << <iq to="test-domain.com" id="KXGMQPIqk1xeAw3s6jYgLCu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="KXGMQPIqk1xeAw3s6jYgLCu" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:13 | << <iq id="t52IKJymUdFHGoQ27ITMGEr" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <iq id="t52IKJymUdFHGoQ27ITMGEr" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="kn4N5kMUP0cvm2jIGyvfR02" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="kn4N5kMUP0cvm2jIGyvfR02" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="ChK4ao8j6FkMQPIqk1xeAw3" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="ChK4ao8j6FkMQPIqk1xeAw3" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:13 | >> <presence to="jaxmpp__cfugl0560@test-domain.com" xmlns="jabber:client" from="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <presence to="jaxmpp__cfugl0560@test-domain.com" xmlns="jabber:client" from="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connected->disconnecting 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4090] Connector state changed: disconnecting->disconnected 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4090] Stream terminated 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="piJLSWZkYbsawr7Bu04u1wv" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="piJLSWZkYbsawr7Bu04u1wv" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | >> <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="t52IKJymUdFHGoQ27ITMGEr" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330 << <iq to="jaxmpp__cfugl0560@test-domain.com/1781077109-tigase-330" xmlns="jabber:client" id="t52IKJymUdFHGoQ27ITMGEr" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testStateAfterAuthTimeoutWebSocket | 20.372s |
2022-08-07 22:43:13 |
2022-08-07 22:43:13 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:43:13 | ------------------------------------ 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-07 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:13 | >> <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:43:33 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3l4MW5oajA1NjEscj1QVm42MHZKMGVzRkp2WWREMVBMWA==</auth> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3l4MW5oajA1NjEscj1QVm42MHZKMGVzRkp2WWREMVBMWA==</auth> 2022-08-07 22:43:33 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QVm42MHZKMGVzRkp2WWREMVBMWFRSWk1vVEJNWTJkZWFDMkg2cTF1LHM9TXZCTlllK255WXczZlE9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QVm42MHZKMGVzRkp2WWREMVBMWFRSWk1vVEJNWTJkZWFDMkg2cTF1LHM9TXZCTlllK255WXczZlE9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:33 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UFZuNjB2SjBlc0ZKdllkRDFQTFhUUlpNb1RCTVkyZGVhQzJINnExdSxwPSt6WStnSCtSaEg3K2JqbVVQd2ljVVdXN0dhbzNMT3Z3a0IzQnRqNm0vLzQ9</response> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UFZuNjB2SjBlc0ZKdllkRDFQTFhUUlpNb1RCTVkyZGVhQzJINnExdSxwPSt6WStnSCtSaEg3K2JqbVVQd2ljVVdXN0dhbzNMT3Z3a0IzQnRqNm0vLzQ9</response> 2022-08-07 22:43:33 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VbUR5S2ZwUCtKem1reXZ6U05hZjlhSE8yVFlaaXBZN3FYMklaQ1FYK0lrPQ==</success> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VbUR5S2ZwUCtKem1reXZ6U05hZjlhSE8yVFlaaXBZN3FYMklaQ1FYK0lrPQ==</success> 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:33 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | >> <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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="cwecoU6lKush3gEEjY8n6wh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com >> <iq xmlns="jabber:client" id="cwecoU6lKush3gEEjY8n6wh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="j3Nl3BmQ25wezuiPKKGLLT4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com >> <iq xmlns="jabber:client" id="j3Nl3BmQ25wezuiPKKGLLT4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="xa6JEHDDy8k03ADgEAjGmcL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com >> <iq xmlns="jabber:client" id="xa6JEHDDy8k03ADgEAjGmcL" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="QzhcTW0mJOOJOW7kU0p3teu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331 >> <iq xmlns="jabber:client" id="QzhcTW0mJOOJOW7kU0p3teu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | >> <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="cwecoU6lKush3gEEjY8n6wh" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331</jid></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331 << <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331" xmlns="jabber:client" id="cwecoU6lKush3gEEjY8n6wh" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-331</jid></bind></iq> 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="cAikEq8pSKYj7oUal2gDCyl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332 >> <iq xmlns="jabber:client" id="cAikEq8pSKYj7oUal2gDCyl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | >> <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332" xmlns="jabber:client" id="j3Nl3BmQ25wezuiPKKGLLT4" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332</jid></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332 << <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332" xmlns="jabber:client" id="j3Nl3BmQ25wezuiPKKGLLT4" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-332</jid></bind></iq> 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:33 | << <iq xmlns="jabber:client" id="K7R7wbqQaHTW0mJOOJOW7kU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333 >> <iq xmlns="jabber:client" id="K7R7wbqQaHTW0mJOOJOW7kU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:33 | >> <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333" xmlns="jabber:client" id="xa6JEHDDy8k03ADgEAjGmcL" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333</jid></bind></iq> 2022-08-07 22:43:33 | jaxmpp_ :: jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333 << <iq to="jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333" xmlns="jabber:client" id="xa6JEHDDy8k03ADgEAjGmcL" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__yx1nhj0561@test-domain.com/1781077109-tigase-333</jid></bind></iq> 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-07 22:43:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:43:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-07 22:43:36 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testStateAfterConnectionFailureBosh | 0.763s |
2022-08-07 22:43:34 |
2022-08-07 22:43:34 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:43:34 | ------------------------------------ 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-07 22:43: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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:43:34 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2U1ejY1ejA1NjIscj04R3VmZXluQTNXZVJzRHl2QVZXbQ==</auth> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2U1ejY1ejA1NjIscj04R3VmZXluQTNXZVJzRHl2QVZXbQ==</auth> 2022-08-07 22:43:34 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04R3VmZXluQTNXZVJzRHl2QVZXbVVKSVBHRGMxZnE1aHU5SjRRS3ZQLHM9eEgyd3VDbWltQW52U1E9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj04R3VmZXluQTNXZVJzRHl2QVZXbVVKSVBHRGMxZnE1aHU5SjRRS3ZQLHM9eEgyd3VDbWltQW52U1E9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:34 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OEd1ZmV5bkEzV2VSc0R5dkFWV21VSklQR0RjMWZxNWh1OUo0UUt2UCxwPTd3MHNEZVFTZSs2OFFKeUJEMTA1M3IzRk45Y3hNUzZlMmpTNkx0RXd3bkU9</response> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OEd1ZmV5bkEzV2VSc0R5dkFWV21VSklQR0RjMWZxNWh1OUo0UUt2UCxwPTd3MHNEZVFTZSs2OFFKeUJEMTA1M3IzRk45Y3hNUzZlMmpTNkx0RXd3bkU9</response> 2022-08-07 22:43:34 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pbzJ0bHNicnQ4ODJOaStJTWJoTGxnMWwvRmNlb2ZCWUJQS2hqWHhFNkM4PQ==</success> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pbzJ0bHNicnQ4ODJOaStJTWJoTGxnMWwvRmNlb2ZCWUJQS2hqWHhFNkM4PQ==</success> 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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"/><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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:34 | << <iq xmlns="jabber:client" id="GxZi4BcwkNEi4vvasgxq2bI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com >> <iq xmlns="jabber:client" id="GxZi4BcwkNEi4vvasgxq2bI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:34 | >> <iq to="jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="GxZi4BcwkNEi4vvasgxq2bI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334</jid></bind></iq> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com << <iq to="jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334" xmlns="jabber:client" id="GxZi4BcwkNEi4vvasgxq2bI" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334</jid></bind></iq> 2022-08-07 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:34 | << <iq to="test-domain.com" id="py0iW4fQ0fAq2tbJKw6y9M1" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="py0iW4fQ0fAq2tbJKw6y9M1" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:34 | << <iq id="We0Ds1o6rYcAzn7w4cKxyz8" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334 >> <iq id="We0Ds1o6rYcAzn7w4cKxyz8" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:34 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:34 | jaxmpp_ :: jaxmpp__e5z65z0562@test-domain.com/1781077109-tigase-334 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
testStateAfterConnectionFailureSocket | 0.219s |
2022-08-07 22:43:35 |
2022-08-07 22:43:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:43:35 | ------------------------------------ 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: null->connecting 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] DNS entry stored in session object: missing:5222 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing. Trying next. 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: connecting->disconnected 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: null->connecting 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] DNS entry stored in session object: localhost:5222 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connecting->connected 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4142] Start TLS 2022-08-07 22:43:35 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4146] Proceeding TLS 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4146] Start handshake 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:43:35 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A3Z2Q5cDA1NjMscj00VFBTZk9rQ3ZjUm5lUW1EY0NNRw==</auth> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A3Z2Q5cDA1NjMscj00VFBTZk9rQ3ZjUm5lUW1EY0NNRw==</auth> 2022-08-07 22:43:35 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00VFBTZk9rQ3ZjUm5lUW1EY0NNR2JtVVZmb29ua1VNYlhjT1ZpaXYxLHM9OEluTjZUVE5KNFdYVkE9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00VFBTZk9rQ3ZjUm5lUW1EY0NNR2JtVVZmb29ua1VNYlhjT1ZpaXYxLHM9OEluTjZUVE5KNFdYVkE9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:35 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFRQU2ZPa0N2Y1JuZVFtRGNDTUdibVVWZm9vbmtVTWJYY09WaWl2MSxwPWFsUUJrdkRnMlowQU5VdlB0OE12c1BZMEM2VWZqMHVuZWJLRFpzRWs0bmM9</response> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NFRQU2ZPa0N2Y1JuZVFtRGNDTUdibVVWZm9vbmtVTWJYY09WaWl2MSxwPWFsUUJrdkRnMlowQU5VdlB0OE12c1BZMEM2VWZqMHVuZWJLRFpzRWs0bmM9</response> 2022-08-07 22:43:35 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11U2RkbW1ZSXdROGk0VTllejQzRi93SFlxRm9rYWNTbXBoeklLdmE5MVlRPQ==</success> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj11U2RkbW1ZSXdROGk0VTllejQzRi93SFlxRm9rYWNTbXBoeklLdmE5MVlRPQ==</success> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:35 | << <iq xmlns="jabber:client" id="SMwt4uZkQNWcDmY8FzviCiW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com >> <iq xmlns="jabber:client" id="SMwt4uZkQNWcDmY8FzviCiW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="SMwt4uZkQNWcDmY8FzviCiW" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335</jid></bind></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com << <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="SMwt4uZkQNWcDmY8FzviCiW" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335</jid></bind></iq> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:35 | << <iq xmlns="jabber:client" id="blb7HoU6lKush3gEEjY8n6w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 >> <iq xmlns="jabber:client" id="blb7HoU6lKush3gEEjY8n6w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="blb7HoU6lKush3gEEjY8n6w" type="result"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 << <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="blb7HoU6lKush3gEEjY8n6w" type="result"/> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-07 22:43:35 | << <iq to="test-domain.com" id="Lrrr16cS7JCm49Eu5wmX0gI" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 >> <iq to="test-domain.com" id="Lrrr16cS7JCm49Eu5wmX0gI" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:35 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:35 | >> <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="65fd3a4b-adbd-4f70-97cd-e4e58e398871"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 << <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="65fd3a4b-adbd-4f70-97cd-e4e58e398871"/> 2022-08-07 22:43:35 | << <iq id="1qmfGLLT4ao8j6FkMQPIqk1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 >> <iq id="1qmfGLLT4ao8j6FkMQPIqk1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="Lrrr16cS7JCm49Eu5wmX0gI" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 << <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="Lrrr16cS7JCm49Eu5wmX0gI" type="result" from="test-domain.com"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="router"/><identity category="server" name="Tigase ver. 8.3.0-SNAPSHOT-b11967/bf36c6a5" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="list-multi"><value>mailto:abuse@test-domain.com</value><value>xmpp:abuse@test-domain.com</value></field></x><feature var="urn:xmpp:mix:pam:2"/><feature var="urn:xmpp:carbons:2"/><feature var="urn:xmpp:carbons:rules:0"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:xmpp:extdisco:2"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2022-08-07 22:43:35 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="1qmfGLLT4ao8j6FkMQPIqk1" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 << <iq to="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335" xmlns="jabber:client" id="1qmfGLLT4ao8j6FkMQPIqk1" type="result"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connected->disconnecting 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream 2022-08-07 22:43:35 | >> <presence to="jaxmpp__p7gd9p0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335 << <presence to="jaxmpp__p7gd9p0563@test-domain.com" xmlns="jabber:client" from="jaxmpp__p7gd9p0563@test-domain.com/1781077109-tigase-335"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4146] Connector state changed: disconnecting->disconnected 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4146] Stream terminated 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testStateAfterConnectionFailureWebSocket | 0.343s |
2022-08-07 22:43:35 |
2022-08-07 22:43:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-07 22:43:35 | ------------------------------------ 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-07 22:43: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-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-512</mechanism><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-07 22:43:35 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzJrNjN1cDA1NjQscj1xYUFoTXdMaGRiNnhRdzhNQVZxbw==</auth> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzJrNjN1cDA1NjQscj1xYUFoTXdMaGRiNnhRdzhNQVZxbw==</auth> 2022-08-07 22:43:35 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xYUFoTXdMaGRiNnhRdzhNQVZxb2dWMERoR2x4NWRPTERJc3pVMmRpLHM9clZqbGpHQTl3cm5Pb3c9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xYUFoTXdMaGRiNnhRdzhNQVZxb2dWMERoR2x4NWRPTERJc3pVMmRpLHM9clZqbGpHQTl3cm5Pb3c9PSxpPTQwOTY=</challenge> 2022-08-07 22:43:35 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWFBaE13TGhkYjZ4UXc4TUFWcW9nVjBEaEdseDVkT0xESXN6VTJkaSxwPXlmc0s2M2U1aDdMRWJWUG9iLzBFcGdIMmNEUWk5aXBYaVozSGRjN2JOK1k9</response> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWFBaE13TGhkYjZ4UXc4TUFWcW9nVjBEaEdseDVkT0xESXN6VTJkaSxwPXlmc0s2M2U1aDdMRWJWUG9iLzBFcGdIMmNEUWk5aXBYaVozSGRjN2JOK1k9</response> 2022-08-07 22:43:35 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RVGNZVWM1RnRadXZodUducWRlZGZRbDVsQ052VWhnVUxmY2NTTy9jU2hFPQ==</success> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1RVGNZVWM1RnRadXZodUducWRlZGZRbDVsQ052VWhnVUxmY2NTTy9jU2hFPQ==</success> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-07 22:43: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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@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 hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="102jU02k4KCzC47iLXYQifmive8=" node="https://tigase.net/tigase-xmpp-server"/></features> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-07 22:43:35 | << <iq xmlns="jabber:client" id="owwFl2gDCylMOO1hV8iEEla" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com >> <iq xmlns="jabber:client" id="owwFl2gDCylMOO1hV8iEEla" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="owwFl2gDCylMOO1hV8iEEla" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336</jid></bind></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com << <iq to="jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="owwFl2gDCylMOO1hV8iEEla" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336</jid></bind></iq> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-07 22:43:35 | << <iq xmlns="jabber:client" id="Wqc1ezuiPKKGLLT4ao8j6Fk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 >> <iq xmlns="jabber:client" id="Wqc1ezuiPKKGLLT4ao8j6Fk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-07 22:43:35 | >> <iq to="jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="Wqc1ezuiPKKGLLT4ao8j6Fk" type="result"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 << <iq to="jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336" xmlns="jabber:client" id="Wqc1ezuiPKKGLLT4ao8j6Fk" type="result"/> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-07 22:43:35 | << <iq to="test-domain.com" id="nAEHKvmUVcIFq6obBzqSOYZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 >> <iq to="test-domain.com" id="nAEHKvmUVcIFq6obBzqSOYZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-07 22:43:35 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-07 22:43:35 | << <iq id="9vnnN4BcwkNEi4vvasgxq2b" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 >> <iq id="9vnnN4BcwkNEi4vvasgxq2b" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-07 22:43:35 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-07 22:43:35 | >> <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="43de609b-92d3-4388-8035-0e527bf72cc1"/> 2022-08-07 22:43:35 | jaxmpp_ :: jaxmpp__2k63up0564@test-domain.com/1781077109-tigase-336 << <enabled location="f9c07ffec79b" resume="true" max="60" xmlns="urn:xmpp:sm:3" id="43de609b-92d3-4388-8035-0e527bf72cc1"/> 2022-08-07 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-07 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |