Test duration : 63.920s
Passed Tests | ||
---|---|---|
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
testStateAfterAuthTimeoutBosh | 20.502s |
2022-08-23 22:42:32 |
2022-08-23 22:42:32 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:42:32 | ------------------------------------ 2022-08-23 22:42:32 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:42:32 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:42:32 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-23 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-23 22:42:32 | jaxmpp_ :: jaxmpp__wrx08z0559@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-23 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-23 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-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:42:52 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3dyeDA4ejA1NTkscj1mZHFKWTFDa0VFNWVwem0yT2JWVQ==</auth> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3dyeDA4ejA1NTkscj1mZHFKWTFDa0VFNWVwem0yT2JWVQ==</auth> 2022-08-23 22:42:52 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mZHFKWTFDa0VFNWVwem0yT2JWVWZaT0N1ZHJ6ZFlTRUVyRUJNM0pyLHM9Q3BBYllZNVNsU0EwVkE9PSxpPTQwOTY=</challenge> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mZHFKWTFDa0VFNWVwem0yT2JWVWZaT0N1ZHJ6ZFlTRUVyRUJNM0pyLHM9Q3BBYllZNVNsU0EwVkE9PSxpPTQwOTY=</challenge> 2022-08-23 22:42:52 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmRxSlkxQ2tFRTVlcHptMk9iVlVmWk9DdWRyemRZU0VFckVCTTNKcixwPXZNdUZKNVZTK3ZwUUxMU0d1MVdLbTNkaHpwaFRmNXc5NW1yQTlKamlzNFE9</response> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZmRxSlkxQ2tFRTVlcHptMk9iVlVmWk9DdWRyemRZU0VFckVCTTNKcixwPXZNdUZKNVZTK3ZwUUxMU0d1MVdLbTNkaHpwaFRmNXc5NW1yQTlKamlzNFE9</response> 2022-08-23 22:42:52 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13dXpsNnhUUnMremQxdCtlZVFna29ZaHAzSkFKSlVTM0FnSzBtNFZqdjFjPQ==</success> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13dXpsNnhUUnMremQxdCtlZVFna29ZaHAzSkFKSlVTM0FnSzBtNFZqdjFjPQ==</success> 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:42:52 | << <iq xmlns="jabber:client" id="e0xHTWUQ2iBgPUUcul7IrcM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com >> <iq xmlns="jabber:client" id="e0xHTWUQ2iBgPUUcul7IrcM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:42:52 | << <iq xmlns="jabber:client" id="sIDVh25umTUhBuZ4rS9wrdV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com >> <iq xmlns="jabber:client" id="sIDVh25umTUhBuZ4rS9wrdV" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:42:52 | << <iq xmlns="jabber:client" id="e2zL1cqS6qRMRY2s0nbQHIO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com >> <iq xmlns="jabber:client" id="e2zL1cqS6qRMRY2s0nbQHIO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:42:52 | >> <iq id="sIDVh25umTUhBuZ4rS9wrdV" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325</jid></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com << <iq id="sIDVh25umTUhBuZ4rS9wrdV" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325</jid></bind></iq> 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:42:52 | << <iq to="test-domain.com" id="57MT49o5aJGLRdAcqcCfyp4" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325 >> <iq to="test-domain.com" id="57MT49o5aJGLRdAcqcCfyp4" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | << <iq id="4NMjFCfAtWhMXfZ8iCAoNEB" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325 >> <iq id="4NMjFCfAtWhMXfZ8iCAoNEB" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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-23 22:42:52 | >> <iq id="e0xHTWUQ2iBgPUUcul7IrcM" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-326" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-326</jid></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325 << <iq id="e0xHTWUQ2iBgPUUcul7IrcM" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-326" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-326</jid></bind></iq> 2022-08-23 22:42:52 | >> <iq id="e2zL1cqS6qRMRY2s0nbQHIO" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327</jid></bind></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-325 << <iq id="e2zL1cqS6qRMRY2s0nbQHIO" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327</jid></bind></iq> 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:42:52 | << <iq to="test-domain.com" id="10nq1aNDy7kXUdEHJX4am4m" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 >> <iq to="test-domain.com" id="10nq1aNDy7kXUdEHJX4am4m" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | << <iq to="test-domain.com" id="sNI5BGn4wdyzbEjIJsjQ5vv" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 >> <iq to="test-domain.com" id="sNI5BGn4wdyzbEjIJsjQ5vv" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:42:52 | << <iq id="bIrzm7zDqSMU25eLMEGshZs" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 >> <iq id="bIrzm7zDqSMU25eLMEGshZs" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | << <iq id="PLyKIrWbCk2aHP8hS8r0tZg" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 >> <iq id="PLyKIrWbCk2aHP8hS8r0tZg" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | >> <iq id="4NMjFCfAtWhMXfZ8iCAoNEB" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 << <iq id="4NMjFCfAtWhMXfZ8iCAoNEB" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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-23 22:42:52 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@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-23 22:42:52 | >> <iq from="test-domain.com" id="57MT49o5aJGLRdAcqcCfyp4" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 << <iq from="test-domain.com" id="57MT49o5aJGLRdAcqcCfyp4" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:42:52 | >> <iq from="test-domain.com" id="10nq1aNDy7kXUdEHJX4am4m" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 << <iq from="test-domain.com" id="10nq1aNDy7kXUdEHJX4am4m" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:42:52 | >> <presence from="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" to="jaxmpp__wrx08z0559@test-domain.com" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 << <presence from="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" to="jaxmpp__wrx08z0559@test-domain.com" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-08-23 22:42:52 | >> <iq id="bIrzm7zDqSMU25eLMEGshZs" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327 << <iq id="bIrzm7zDqSMU25eLMEGshZs" to="jaxmpp__wrx08z0559@test-domain.com/1781077109-tigase-327" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
testStateAfterAuthTimeoutSocket | 20.237s |
2022-08-23 22:42:52 |
2022-08-23 22:42:52 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:42:52 | ------------------------------------ 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: null->connecting 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222] 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: connecting->connected 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:42:52 | >> <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-23 22:42:52 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4094] Start TLS 2022-08-23 22:42:52 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:42:52 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4096] Proceeding TLS 2022-08-23 22:42:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4096] Start handshake 2022-08-23 22:42:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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-23 22:42:53 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:42:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 22:43:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4096] Connector state changed: connected->disconnected 2022-08-23 22:43:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4096] Stream terminated 2022-08-23 22:43:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: null->connecting 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: localhost:5222 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [localhost:5222] 2022-08-23 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-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connecting->connected 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Whitespace ping period is setted to nullms 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4094] Start TLS 2022-08-23 22:43:13 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4101] Proceeding TLS 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4101] Start handshake 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:43:13 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E5bHVoMTA1NjAscj1jNWxQaHY1OWlNYzdRS2xZdU5QSA==</auth> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E5bHVoMTA1NjAscj1jNWxQaHY1OWlNYzdRS2xZdU5QSA==</auth> 2022-08-23 22:43:13 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jNWxQaHY1OWlNYzdRS2xZdU5QSE1FWXR2eUFMN1JqZ21vMEJBZkJCLHM9aW5aN1A3WWMrWE9nRXc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jNWxQaHY1OWlNYzdRS2xZdU5QSE1FWXR2eUFMN1JqZ21vMEJBZkJCLHM9aW5aN1A3WWMrWE9nRXc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:13 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzVsUGh2NTlpTWM3UUtsWXVOUEhNRVl0dnlBTDdSamdtbzBCQWZCQixwPXY4cFRJdWtacjRHQjFmYnpIR2duWTJOQjRBNXhSencrWTJ3c2VuVnI4Slk9</response> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzVsUGh2NTlpTWM3UUtsWXVOUEhNRVl0dnlBTDdSamdtbzBCQWZCQixwPXY4cFRJdWtacjRHQjFmYnpIR2duWTJOQjRBNXhSencrWTJ3c2VuVnI4Slk9</response> 2022-08-23 22:43:13 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZQ2ZrQXd6dVQ3VnpGa25TMGcyeVVEU01rc0xVL0lxMEJjSkhsajdzSVJJPQ==</success> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ZQ2ZrQXd6dVQ3VnpGa25TMGcyeVVEU01rc0xVL0lxMEJjSkhsajdzSVJJPQ==</success> 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="0OzKSVYpR018z8Fyvlbw4aG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <iq xmlns="jabber:client" id="0OzKSVYpR018z8Fyvlbw4aG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="d2d7zDqSMU25eLMEGshZsVa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <iq xmlns="jabber:client" id="d2d7zDqSMU25eLMEGshZsVa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | >> <iq id="0OzKSVYpR018z8Fyvlbw4aG" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328</jid></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com << <iq id="0OzKSVYpR018z8Fyvlbw4aG" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328</jid></bind></iq> 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="5iXfMzeLwr6BxziCgSYXYfK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com >> <iq xmlns="jabber:client" id="5iXfMzeLwr6BxziCgSYXYfK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="h03qS6qRMRY2s0nbQHIONIT" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328 >> <iq xmlns="jabber:client" id="h03qS6qRMRY2s0nbQHIONIT" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | >> <iq id="d2d7zDqSMU25eLMEGshZsVa" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329</jid></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-328 << <iq id="d2d7zDqSMU25eLMEGshZsVa" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329</jid></bind></iq> 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="SSDCxkKSQ3xy7yu9qjFCfAt" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329 >> <iq xmlns="jabber:client" id="SSDCxkKSQ3xy7yu9qjFCfAt" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | >> <iq id="5iXfMzeLwr6BxziCgSYXYfK" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330</jid></bind></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329 << <iq id="5iXfMzeLwr6BxziCgSYXYfK" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330</jid></bind></iq> 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:13 | << <iq xmlns="jabber:client" id="WYTs0nbQHIONITPWTS36Bqf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq xmlns="jabber:client" id="WYTs0nbQHIONITPWTS36Bqf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:13 | >> <iq id="h03qS6qRMRY2s0nbQHIONIT" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 << <iq id="h03qS6qRMRY2s0nbQHIONIT" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:13 | << <iq to="test-domain.com" id="J7ihThIsWeGnOV6iY2rj6dK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="J7ihThIsWeGnOV6iY2rj6dK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | >> <iq id="SSDCxkKSQ3xy7yu9qjFCfAt" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 << <iq id="SSDCxkKSQ3xy7yu9qjFCfAt" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-329" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:13 | >> <iq id="WYTs0nbQHIONITPWTS36Bqf" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 << <iq id="WYTs0nbQHIONITPWTS36Bqf" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:13 | << <iq id="HUDX8FFPOEk0et0jSQ4eP5E" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq id="HUDX8FFPOEk0et0jSQ4eP5E" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | >> <enabled resume="true" id="cc237bd5-5d47-4648-8d51-356dc0e5fa57" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 << <enabled resume="true" id="cc237bd5-5d47-4648-8d51-356dc0e5fa57" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:13 | << <iq to="test-domain.com" id="36bM15sVWbm7sjXpYYYiODk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="36bM15sVWbm7sjXpYYYiODk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | << <iq to="test-domain.com" id="clSgVbRSMAwgx8zoS8m5BGn" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq to="test-domain.com" id="clSgVbRSMAwgx8zoS8m5BGn" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:13 | << <iq id="Bq5viBiTMX8FFPOEk0et0jS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq id="Bq5viBiTMX8FFPOEk0et0jS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:43:13 | << <iq id="N8bGo8uZ2n06AgTdUPYkPM1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 >> <iq id="N8bGo8uZ2n06AgTdUPYkPM1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:43:13 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@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-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connected->disconnecting 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Terminating XMPP Stream 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:13 | >> <iq from="test-domain.com" id="J7ihThIsWeGnOV6iY2rj6dK" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:43:13 | jaxmpp_ :: jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330 << <iq from="test-domain.com" id="J7ihThIsWeGnOV6iY2rj6dK" to="jaxmpp__q9luh10560@test-domain.com/1781077109-tigase-330" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=4101] Connector state changed: disconnecting->disconnected |
testStateAfterAuthTimeoutWebSocket | 20.357s |
2022-08-23 22:43:13 |
2022-08-23 22:43:13 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:43:13 | ------------------------------------ 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-23 22:43:13 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:13 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 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-23 22:43:13 | jaxmpp_ :: jaxmpp__5uwz3e0561@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-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@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-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:43:33 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzV1d3ozZTA1NjEscj11bEJoQm1MV3pTa2F6dmNPbk5SWQ==</auth> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzV1d3ozZTA1NjEscj11bEJoQm1MV3pTa2F6dmNPbk5SWQ==</auth> 2022-08-23 22:43:33 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11bEJoQm1MV3pTa2F6dmNPbk5SWTRSVzRRTHdMTm5LNTJ0ZnAyOENzLHM9YUg0ZUtwcGRHY1VsSGc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11bEJoQm1MV3pTa2F6dmNPbk5SWTRSVzRRTHdMTm5LNTJ0ZnAyOENzLHM9YUg0ZUtwcGRHY1VsSGc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:33 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWxCaEJtTFd6U2thenZjT25OUlk0Ulc0UUx3TE5uSzUydGZwMjhDcyxwPTRhLy8xZVNEWnhpdlFMaG1Scm5vQlFhMHhQdzdOUkV3V0ErOHpnR0lqalk9</response> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dWxCaEJtTFd6U2thenZjT25OUlk0Ulc0UUx3TE5uSzUydGZwMjhDcyxwPTRhLy8xZVNEWnhpdlFMaG1Scm5vQlFhMHhQdzdOUkV3V0ErOHpnR0lqalk9</response> 2022-08-23 22:43:33 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10Qmt1bm9yRjFueWNMdncwNlhPUG1EaUdHQlJDTFJ6VVBZSERUYStzZURrPQ==</success> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10Qmt1bm9yRjFueWNMdncwNlhPUG1EaUdHQlJDTFJ6VVBZSERUYStzZURrPQ==</success> 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="koQbnOV6iY2rj6dKSVYpR01" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com >> <iq xmlns="jabber:client" id="koQbnOV6iY2rj6dKSVYpR01" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="ZqUww3qeDofxmJypO1gVbRS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com >> <iq xmlns="jabber:client" id="ZqUww3qeDofxmJypO1gVbRS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="uv7ZZiY7mbp6dwlGLKT7JCg" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com >> <iq xmlns="jabber:client" id="uv7ZZiY7mbp6dwlGLKT7JCg" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:33 | >> <iq id="koQbnOV6iY2rj6dKSVYpR01" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-331" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-331</jid></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com << <iq id="koQbnOV6iY2rj6dKSVYpR01" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-331" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-331</jid></bind></iq> 2022-08-23 22:43:33 | >> <iq id="ZqUww3qeDofxmJypO1gVbRS" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-332" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-332</jid></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com << <iq id="ZqUww3qeDofxmJypO1gVbRS" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-332" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-332</jid></bind></iq> 2022-08-23 22:43:33 | >> <iq id="uv7ZZiY7mbp6dwlGLKT7JCg" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333</jid></bind></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com << <iq id="uv7ZZiY7mbp6dwlGLKT7JCg" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333</jid></bind></iq> 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="n91Cu4w8DHSLQ4jKXXcpU7e" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq xmlns="jabber:client" id="n91Cu4w8DHSLQ4jKXXcpU7e" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="VmCBAgTdUPYkPM15sVWbm7s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq xmlns="jabber:client" id="VmCBAgTdUPYkPM15sVWbm7s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | << <iq xmlns="jabber:client" id="qd9X0nbQHIONITPWTS36Bqf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq xmlns="jabber:client" id="qd9X0nbQHIONITPWTS36Bqf" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:33 | >> <iq id="n91Cu4w8DHSLQ4jKXXcpU7e" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 << <iq id="n91Cu4w8DHSLQ4jKXXcpU7e" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | >> <iq id="VmCBAgTdUPYkPM15sVWbm7s" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 << <iq id="VmCBAgTdUPYkPM15sVWbm7s" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | >> <iq id="qd9X0nbQHIONITPWTS36Bqf" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 << <iq id="qd9X0nbQHIONITPWTS36Bqf" to="jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:33 | << <iq to="test-domain.com" id="9eaUO1gVbRSMAwgx8zoS8m5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq to="test-domain.com" id="9eaUO1gVbRSMAwgx8zoS8m5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | << <iq to="test-domain.com" id="4hhiDy7kXUdEHJX4am4mJwl" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq to="test-domain.com" id="4hhiDy7kXUdEHJX4am4mJwl" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | << <iq to="test-domain.com" id="Ygc2vuZiY7mbp6dwlGLKT7J" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq to="test-domain.com" id="Ygc2vuZiY7mbp6dwlGLKT7J" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:33 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:33 | << <iq id="Yhd4zCfO0burV8hEBcNO1nf" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq id="Yhd4zCfO0burV8hEBcNO1nf" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | << <iq id="3ntl9lYX0jCDun5Fu02q49m" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq id="3ntl9lYX0jCDun5Fu02q49m" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | << <iq id="yB7GurV8hEBcNO1nfEkGIEj" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <iq id="yB7GurV8hEBcNO1nfEkGIEj" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:33 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-23 22:43:33 | >> <enabled resume="true" id="1dcc13f8-ed7f-49ff-b6e9-ddd45705b4e1" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:33 | jaxmpp_ :: jaxmpp__5uwz3e0561@test-domain.com/1781077109-tigase-333 << <enabled resume="true" id="1dcc13f8-ed7f-49ff-b6e9-ddd45705b4e1" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected |
testStateAfterConnectionFailureBosh | 0.723s |
2022-08-23 22:43:33 |
2022-08-23 22:43:33 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:43:33 | ------------------------------------ 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-23 22:43:33 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2022-08-23 22:43:33 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2022-08-23 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-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@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-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:43:34 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX21pdWFlaDA1NjIscj1Ga2s2cjBSY1J6TGQ2aDJVVFNIOQ==</auth> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX21pdWFlaDA1NjIscj1Ga2s2cjBSY1J6TGQ2aDJVVFNIOQ==</auth> 2022-08-23 22:43:34 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Ga2s2cjBSY1J6TGQ2aDJVVFNIOWxjWEFaQkp4UWY0WnM1U1VpTVI3LHM9dzVuZHBKdlNCYUtYbkE9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Ga2s2cjBSY1J6TGQ2aDJVVFNIOWxjWEFaQkp4UWY0WnM1U1VpTVI3LHM9dzVuZHBKdlNCYUtYbkE9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:34 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RmtrNnIwUmNSekxkNmgyVVRTSDlsY1hBWkJKeFFmNFpzNVNVaU1SNyxwPWhDYzFaRTNnSnFoWkF1MzFtdEpLUUx0ZEU4bmoxa2YvS2hWUWxMSzdvMzQ9</response> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RmtrNnIwUmNSekxkNmgyVVRTSDlsY1hBWkJKeFFmNFpzNVNVaU1SNyxwPWhDYzFaRTNnSnFoWkF1MzFtdEpLUUx0ZEU4bmoxa2YvS2hWUWxMSzdvMzQ9</response> 2022-08-23 22:43:34 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1GT0ZKRDl2V3J6ZHdyRGFwb1hwOWZUNHkyZGQ0MFVaMGo2SUJWOW5NTHFRPQ==</success> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1GT0ZKRDl2V3J6ZHdyRGFwb1hwOWZUNHkyZGQ0MFVaMGo2SUJWOW5NTHFRPQ==</success> 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:34 | << <iq xmlns="jabber:client" id="oAWpUcul7IrcMJADjUPKNAz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com >> <iq xmlns="jabber:client" id="oAWpUcul7IrcMJADjUPKNAz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:34 | >> <iq id="oAWpUcul7IrcMJADjUPKNAz" to="jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334</jid></bind></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com << <iq id="oAWpUcul7IrcMJADjUPKNAz" to="jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334</jid></bind></iq> 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:34 | << <iq to="test-domain.com" id="oBXrYkKR9MzsiLELzqROVQ5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334 >> <iq to="test-domain.com" id="oBXrYkKR9MzsiLELzqROVQ5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:34 | << <iq id="yHdSSdtet2nKT0p9NKw4ucp" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@test-domain.com/1781077109-tigase-334 >> <iq id="yHdSSdtet2nKT0p9NKw4ucp" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:34 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__miuaeh0562@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-23 22:43:34 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=404 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
testStateAfterConnectionFailureSocket | 0.244s |
2022-08-23 22:43:34 |
2022-08-23 22:43:34 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:43:34 | ------------------------------------ 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: null->connecting 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] DNS entry stored in session object: missing:5222 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Preparing connection to [missing:5222] 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] missing. Trying next. 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=638 thread=1] Connector state changed: connecting->disconnected 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: null->connecting 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] DNS entry stored in session object: localhost:5222 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Preparing connection to [localhost:5222] 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Opening connection to localhost/127.0.0.1:5222 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connecting->connected 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Whitespace ping period is setted to nullms 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 22:43:34 | >> <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-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@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-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4154] Start TLS 2022-08-23 22:43:34 | << <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4158] Proceeding TLS 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4158] Start handshake 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@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-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:43:34 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2JkN2R4MDA1NjMscj0xWUllV0FtNmw4SEVMU2t6SXRjQg==</auth> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2JkN2R4MDA1NjMscj0xWUllV0FtNmw4SEVMU2t6SXRjQg==</auth> 2022-08-23 22:43:34 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xWUllV0FtNmw4SEVMU2t6SXRjQjJWd1NvQnZnTFNtazZ6UDhjSHhQLHM9YlNCUUh6ZElPTHNPamc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xWUllV0FtNmw4SEVMU2t6SXRjQjJWd1NvQnZnTFNtazZ6UDhjSHhQLHM9YlNCUUh6ZElPTHNPamc9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:34 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MVlJZVdBbTZsOEhFTFNrekl0Y0IyVndTb0J2Z0xTbWs2elA4Y0h4UCxwPTJ3RTdPR1A1VGNLL0pHYXIyTUxtR1NrRitZbDFiYmgzdnZiL2hsNElXZFE9</response> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MVlJZVdBbTZsOEhFTFNrekl0Y0IyVndTb0J2Z0xTbWs2elA4Y0h4UCxwPTJ3RTdPR1A1VGNLL0pHYXIyTUxtR1NrRitZbDFiYmgzdnZiL2hsNElXZFE9</response> 2022-08-23 22:43:34 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1BQ3M5dFVlSFB6aVRyWXYzOHJUaDdlOUNSMW9YUHdyQ1NpVm5WMHk0dzdZPQ==</success> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1BQ3M5dFVlSFB6aVRyWXYzOHJUaDdlOUNSMW9YUHdyQ1NpVm5WMHk0dzdZPQ==</success> 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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"/><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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:34 | << <iq xmlns="jabber:client" id="gSCFmKQUPIJIwqWfVkFEGxc" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com >> <iq xmlns="jabber:client" id="gSCFmKQUPIJIwqWfVkFEGxc" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:34 | >> <iq id="gSCFmKQUPIJIwqWfVkFEGxc" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335</jid></bind></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com << <iq id="gSCFmKQUPIJIwqWfVkFEGxc" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335</jid></bind></iq> 2022-08-23 22:43:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:34 | << <iq xmlns="jabber:client" id="ZLfcSLQ4jKXXcpU7eRWhThI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 >> <iq xmlns="jabber:client" id="ZLfcSLQ4jKXXcpU7eRWhThI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:34 | >> <iq id="ZLfcSLQ4jKXXcpU7eRWhThI" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 << <iq id="ZLfcSLQ4jKXXcpU7eRWhThI" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:34 | << <iq to="test-domain.com" id="TtlgMEGshZsVaIBk7hQHuhy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 >> <iq to="test-domain.com" id="TtlgMEGshZsVaIBk7hQHuhy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:34 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:34 | >> <enabled resume="true" id="8e8c61c6-3f15-4910-a020-8a74565d41a5" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 << <enabled resume="true" id="8e8c61c6-3f15-4910-a020-8a74565d41a5" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:34 | << <iq id="JEQm3BmKwo016vgCCk1tqR2" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 >> <iq id="JEQm3BmKwo016vgCCk1tqR2" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:34 | >> <iq from="test-domain.com" id="TtlgMEGshZsVaIBk7hQHuhy" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 << <iq from="test-domain.com" id="TtlgMEGshZsVaIBk7hQHuhy" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="router" category="component"/><identity name="Tigase ver. 8.3.0-SNAPSHOT-b12032/bf36c6a5" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:reporting:0"/><feature var="urn:xmpp:reporting:abuse:0"/><feature var="urn:xmpp:reporting:spam:0"/><feature var="urn:xmpp:reporting:1"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:jingle:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="urn:xmpp:mam:2"/><feature var="urn:xmpp:mam:2#extended"/><feature var="urn:xmpp:mix:pam:2#archive"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn: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-23 22:43:34 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@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-23 22:43:34 | >> <iq id="JEQm3BmKwo016vgCCk1tqR2" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:34 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 << <iq id="JEQm3BmKwo016vgCCk1tqR2" to="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:35 | >> <presence from="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" to="jaxmpp__bd7dx00563@test-domain.com" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335 << <presence from="jaxmpp__bd7dx00563@test-domain.com/1781077109-tigase-335" to="jaxmpp__bd7dx00563@test-domain.com" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps"/></presence> 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Connector state changed: connected->disconnecting 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=1] Terminating XMPP Stream 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=639 thread=4158] Connector state changed: disconnecting->disconnected 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
testStateAfterConnectionFailureWebSocket | 0.353s |
2022-08-23 22:43:35 |
2022-08-23 22:43:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2022-08-23 22:43:35 | ------------------------------------ 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@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-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedtrue, nonSaslSupported: true 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2022-08-23 22:43:35 | << <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzd5ZGgzcTA1NjQscj1qRFNpYk8wVkpYNThPZ0k4NUViSA==</auth> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzd5ZGgzcTA1NjQscj1qRFNpYk8wVkpYNThPZ0k4NUViSA==</auth> 2022-08-23 22:43:35 | >> <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qRFNpYk8wVkpYNThPZ0k4NUViSHNRb203T3p5Z0dUY2hrTGQ3OXNELHM9Z2E0aXNTY1NpQVhSeVE9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qRFNpYk8wVkpYNThPZ0k4NUViSHNRb203T3p5Z0dUY2hrTGQ3OXNELHM9Z2E0aXNTY1NpQVhSeVE9PSxpPTQwOTY=</challenge> 2022-08-23 22:43:35 | << <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akRTaWJPMFZKWDU4T2dJODVFYkhzUW9tN096eWdHVGNoa0xkNzlzRCxwPUswbUt1RW9pS2dOMi9YUW4rWXBiQUh1VWZNRDExak5CK1FPZ0JZdWVuS0E9</response> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9akRTaWJPMFZKWDU4T2dJODVFYkhzUW9tN096eWdHVGNoa0xkNzlzRCxwPUswbUt1RW9pS2dOMi9YUW4rWXBiQUh1VWZNRDExak5CK1FPZ0JZdWVuS0E9</response> 2022-08-23 22:43:35 | >> <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LV2kwVWs0VWo4YWhqVWFhQkdRRGN2VEhuTk9ON2lUangxckJLQkRaNFM4PQ==</success> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LV2kwVWs0VWo4YWhqVWFhQkdRRGN2VEhuTk9ON2lUangxckJLQkRaNFM4PQ==</success> 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2022-08-23 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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@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 node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" ver="OkrxIJKUeS7y6/hdrEfXISfG50M=" xmlns="http://jabber.org/protocol/caps"/></features> 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.isAuthAvailable: saslSupportedfalse, nonSaslSupported: false 2022-08-23 22:43:35 | << <iq xmlns="jabber:client" id="mvhT5qWgCBDKvk2fCHralMR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com >> <iq xmlns="jabber:client" id="mvhT5qWgCBDKvk2fCHralMR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2022-08-23 22:43:35 | >> <iq id="mvhT5qWgCBDKvk2fCHralMR" to="jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336</jid></bind></iq> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com << <iq id="mvhT5qWgCBDKvk2fCHralMR" to="jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336</jid></bind></iq> 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2022-08-23 22:43:35 | << <iq xmlns="jabber:client" id="uWyRJMW3eVT49o5aJGLRdAc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 >> <iq xmlns="jabber:client" id="uWyRJMW3eVT49o5aJGLRdAc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2022-08-23 22:43:35 | >> <iq id="uWyRJMW3eVT49o5aJGLRdAc" to="jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 << <iq id="uWyRJMW3eVT49o5aJGLRdAc" to="jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336" type="result" xmlns="jabber:client"/> 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2022-08-23 22:43:35 | << <iq to="test-domain.com" id="GPbDFyvlbw4aGAbq9ycMEFL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 >> <iq to="test-domain.com" id="GPbDFyvlbw4aGAbq9ycMEFL" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2022-08-23 22:43:35 | << <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2022-08-23 22:43:35 | << <iq id="FDzIqfIPZt6eukSLAtcumOZ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 >> <iq id="FDzIqfIPZt6eukSLAtcumOZ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2022-08-23 22:43:35 | << <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@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-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2022-08-23 22:43:35 | >> <enabled resume="true" id="770aca02-d217-4cfc-8b78-24ff77d90756" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:35 | jaxmpp_ :: jaxmpp__7ydh3q0564@test-domain.com/1781077109-tigase-336 << <enabled resume="true" id="770aca02-d217-4cfc-8b78-24ff77d90756" max="60" location="f9c07ffec79b" xmlns="urn:xmpp:sm:3"/> 2022-08-23 22:43:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2022-08-23 22:43:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |