Test duration: 64.960s
Passed Tests | ||
---|---|---|
tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
testStateAfterAuthTimeoutBosh | 20.514s |
2019-11-25 19:06:08 |
2019-11-25 19:06:08 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:06:08 | ------------------------------------ 2019-11-25 19:06:08 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:06:08 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:06:08 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-25 19:06:08 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A0aGJzdzA1MzMscj1RYktSYWZFYzVqdVhDRmVhREtsSA==</auth> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RYktSYWZFYzVqdVhDRmVhREtsSHF2anMwckVQOEhMaXg5T0c2OTExLHM9NnNKM3prZFJ4YVUwUlE9PSxpPTQwOTY=</challenge> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UWJLUmFmRWM1anVYQ0ZlYURLbEhxdmpzMHJFUDhITGl4OU9HNjkxMSxwPWFFQ2crZytva3NKdTdtT29NdUZRR2NuQWkzT0FsWXpzdERKMHA2N0ZlRWc9</response> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj15dzVyS3NFMTlSTXl2QjdyVjBDM0RIUmlWaksxYTBxY3oza3RZS0twYU04PQ==</success> 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost >> <iq xmlns="jabber:client" id="l0O7v1eIUYhHsgHqgWV5ywn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost >> <iq xmlns="jabber:client" id="kq2waBdCus4t5eONCEItbKU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost >> <iq xmlns="jabber:client" id="7lLjX5fx4dSM2wh29q7fGCI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost << <iq id="l0O7v1eIUYhHsgHqgWV5ywn" type="result" xmlns="jabber:client" to="jaxmpp__p4hbsw0533@localhost/993927746-tigase-288"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4hbsw0533@localhost/993927746-tigase-288</jid></bind></iq> 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-288 >> <iq to="localhost" id="20IdQJHMYhJx7exw4CGBGr0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-288 >> <iq id="TgsiMO6m3fys5cO27tk4t7j" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-288 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-288 << <iq id="7lLjX5fx4dSM2wh29q7fGCI" type="result" xmlns="jabber:client" to="jaxmpp__p4hbsw0533@localhost/993927746-tigase-290"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4hbsw0533@localhost/993927746-tigase-290</jid></bind></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-288 << <iq id="kq2waBdCus4t5eONCEItbKU" type="result" xmlns="jabber:client" to="jaxmpp__p4hbsw0533@localhost/993927746-tigase-289"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4hbsw0533@localhost/993927746-tigase-289</jid></bind></iq> 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 >> <iq to="localhost" id="WgqHyr16yhAAAdFIQ1dv36h" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 >> <iq to="localhost" id="c4P05Cg0s9MDo37q6GwnTQ2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 >> <iq id="K7WGogYbQLEz9ueW2pXYiLy" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 << <iq from="localhost" id="20IdQJHMYhJx7exw4CGBGr0" type="result" xmlns="jabber:client" to="jaxmpp__p4hbsw0533@localhost/993927746-tigase-290"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 << <iq id="TgsiMO6m3fys5cO27tk4t7j" type="result" xmlns="jabber:client" to="jaxmpp__p4hbsw0533@localhost/993927746-tigase-290"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 >> <iq id="H8XjCj4aO4nexcFlS0u8BlK" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__p4hbsw0533@localhost/993927746-tigase-289 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
testStateAfterAuthTimeoutSocket | 20.270s |
2019-11-25 19:06:28 |
2019-11-25 19:06:28 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:06:28 | ------------------------------------ 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Connector state changed: null->connecting 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] DNS entry stored in session object: localhost:5222 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Preparing connection to [localhost:5222] 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Connector state changed: connecting->connected 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Whitespace ping period is setted to nullms 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><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> 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3846] Start TLS 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3848] Proceeding TLS 2019-11-25 19:06:28 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3848] Start handshake 2019-11-25 19:06:28 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:28 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3848] Connector state changed: connected->disconnected 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3848] Stream terminated 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:06:48 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: null->connecting 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] DNS entry stored in session object: localhost:5222 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Preparing connection to [localhost:5222] 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-25 19:06:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: connecting->connected 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Whitespace ping period is setted to nullms 2019-11-25 19:06:48 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><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> 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3846] Start TLS 2019-11-25 19:06:48 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3853] Proceeding TLS 2019-11-25 19:06:48 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3853] Start handshake 2019-11-25 19:06:48 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2ZkcmRwazA1MzQscj1DNlRsZDNHWDNWb0lHbHREREgwTg==</auth> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DNlRsZDNHWDNWb0lHbHREREgwTkZua1pMS3hacU9nRjhCVW55TGEzLHM9eWh5UklON3ViZEtpK3c9PSxpPTQwOTY=</challenge> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QzZUbGQzR1gzVm9JR2x0RERIME5GbmtaTEt4WnFPZ0Y4QlVueUxhMyxwPVRQdHdCM25zVW1kcUJuYUxPUUlPMUlaQldyTGFBbEtBZUt2NUhSWjNOMnc9</response> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oNHpuSVNDT2dLT2xkSzRnaVpsR2RXNjlCSzVGd1hnOUovdVhLNU92OUNrPQ==</success> 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <iq xmlns="jabber:client" id="3x2QJHMYhJx7exw4CGBGr0h" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <iq xmlns="jabber:client" id="fA9GQ8vu3eJt8wwcJBgSVSa" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost >> <iq xmlns="jabber:client" id="CoxO2pZ39iFMAEKJWX2lHAq" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost << <iq id="3x2QJHMYhJx7exw4CGBGr0h" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-291"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__fdrdpk0534@localhost/993927746-tigase-291</jid></bind></iq> 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-291 >> <iq xmlns="jabber:client" id="obSiQaujLAwdsk4bBAAvbrV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-291 << <iq id="fA9GQ8vu3eJt8wwcJBgSVSa" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-292"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__fdrdpk0534@localhost/993927746-tigase-292</jid></bind></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-291 << <iq id="CoxO2pZ39iFMAEKJWX2lHAq" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__fdrdpk0534@localhost/993927746-tigase-293</jid></bind></iq> 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq xmlns="jabber:client" id="Sje5bymcyr16yhAAAdFIQ1d" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq xmlns="jabber:client" id="rGj8BlKQRKUevfSaFv5dqVi" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <iq id="obSiQaujLAwdsk4bBAAvbrV" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"/> 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq to="localhost" id="kHk5iRJEyAkZ7iW38GMBrgW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <iq id="Sje5bymcyr16yhAAAdFIQ1d" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"/> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq id="hIludUTU5bymcyr16yhAAAd" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <enabled location="d4270859fb27" id="54a77f04-b486-4007-b3a0-170734502938" max="60" xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq to="localhost" id="CuD0qbx9lGrkGQ8vu3eJt8w" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <iq id="rGj8BlKQRKUevfSaFv5dqVi" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"/> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <iq from="localhost" id="kHk5iRJEyAkZ7iW38GMBrgW" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq id="Bj4JQ6xfzbmN26GORct4pPQ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq to="localhost" id="9CXrXXUTeusmXoRQXV2k8qb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <iq id="XMpkZ7iW38GMBrgWdBhBcto" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__fdrdpk0534@localhost/993927746-tigase-293 << <iq id="hIludUTU5bymcyr16yhAAAd" type="result" xmlns="jabber:client" to="jaxmpp__fdrdpk0534@localhost/993927746-tigase-293"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: connected->disconnecting 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Terminating XMPP Stream 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3853] Connector state changed: disconnecting->disconnected 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3853] Stream terminated 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testStateAfterAuthTimeoutWebSocket | 20.384s |
2019-11-25 19:06:49 |
2019-11-25 19:06:49 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:06:49 | ------------------------------------ 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-25 19:06:49 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-25 19:06:49 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:06:49 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2JuaXQ1bjA1MzUscj1kZGxBcTZPSWp3S1VYMHNXYk5YeQ==</auth> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kZGxBcTZPSWp3S1VYMHNXYk5YeTNwQWlpa2pFZTBjcG9HYkpTRGpxLHM9aDJYOG9tM21NdThOU2c9PSxpPTQwOTY=</challenge> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZGRsQXE2T0lqd0tVWDBzV2JOWHkzcEFpaWtqRWUwY3BvR2JKU0RqcSxwPUtpbUdncmxJdWJLWTRqd3ljbnZEZFMyY1k1U0l6UmNDR2lqQkxqYk11eHc9</response> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16WkJnNzBrVDA4cm1zWUhPalgzM2xFbHN3RktDZGlhTFlQcmh1WFJYSEMwPQ==</success> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost >> <iq xmlns="jabber:client" id="DKb8BnPHoRamcQVkJArTYcS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost >> <iq xmlns="jabber:client" id="9I3DlJsZqSeU3AfCv1eIUYh" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost >> <iq xmlns="jabber:client" id="8OjjNFnKzAcScDKzgNBo2yg" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <iq id="DKb8BnPHoRamcQVkJArTYcS" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-294"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bnit5n0535@localhost/993927746-tigase-294</jid></bind></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <iq id="9I3DlJsZqSeU3AfCv1eIUYh" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-295"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bnit5n0535@localhost/993927746-tigase-295</jid></bind></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost << <iq id="8OjjNFnKzAcScDKzgNBo2yg" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-296"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bnit5n0535@localhost/993927746-tigase-296</jid></bind></iq> 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq xmlns="jabber:client" id="YzyNJwoXWi03l4yr3bpOHQI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq xmlns="jabber:client" id="ysb8Gp3uo7pTPEncqk6rmNI" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq xmlns="jabber:client" id="ytcaKxj0qbx9lGrkGQ8vu3e" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 << <iq id="YzyNJwoXWi03l4yr3bpOHQI" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-296"/> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 << <iq id="ysb8Gp3uo7pTPEncqk6rmNI" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-296"/> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 << <iq id="ytcaKxj0qbx9lGrkGQ8vu3e" type="result" xmlns="jabber:client" to="jaxmpp__bnit5n0535@localhost/993927746-tigase-296"/> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq to="localhost" id="GDEJv05Cg0s9MDo37q6GwnT" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq to="localhost" id="Mvei2j6hGDhKKY6xdukPGMY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq to="localhost" id="OWvBGr0hzkUiKPNEEtYm8jR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq id="hZC2j6hGDhKKY6xdukPGMYZ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq id="bBqfu3y8KW7Iv8x5mYq0lPI" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <iq id="iZyHSPMPFwi4iVZ2q14yw5p" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-25 19:07:09 | jaxmpp_ :: jaxmpp__bnit5n0535@localhost/993927746-tigase-296 << <enabled location="d4270859fb27" id="c6b87cfe-b597-4804-9ca0-e650adafedcb" max="60" xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:09 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:07:09 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-25 19:07:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
testStateAfterConnectionFailureBosh | 0.792s |
2019-11-25 19:07:10 |
2019-11-25 19:07:10 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:07:10 | ------------------------------------ 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3d6dmlqdDA1MzYscj01Qk1MQ0lHOW9QcmZsa0xibzdXWA==</auth> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01Qk1MQ0lHOW9QcmZsa0xibzdXWFRWMG04RTdhQmsyODlRdDRVZ0VvLHM9NHRsSHh2OUVzWXdibmc9PSxpPTQwOTY=</challenge> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NUJNTENJRzlvUHJmbGtMYm83V1hUVjBtOEU3YUJrMjg5UXQ0VWdFbyxwPUVncGRZNXZNTGFIUFYyeWFYeUZ4RzZXLy94R3JpOEdkdmtFcEZVcHpGdUk9</response> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zVnFYaFdxd3VDcVo4VE5OaFVUNGRCejE4OUttalN2b1FWdHgrN0gwNDhnPQ==</success> 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost >> <iq xmlns="jabber:client" id="O3CP8lOTNMO6m3fys5cO27t" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost << <iq id="O3CP8lOTNMO6m3fys5cO27t" type="result" xmlns="jabber:client" to="jaxmpp__wzvijt0536@localhost/993927746-tigase-297"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__wzvijt0536@localhost/993927746-tigase-297</jid></bind></iq> 2019-11-25 19:07:10 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost/993927746-tigase-297 >> <iq to="localhost" id="r6JYhHsgHqgWV5ywnVVTMDI" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost/993927746-tigase-297 >> <iq id="9Yj9nNAfWUi2j6hGDhKKY6x" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:10 | jaxmpp_ :: jaxmpp__wzvijt0536@localhost/993927746-tigase-297 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:07:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
testStateAfterConnectionFailureSocket | 0.268s |
2019-11-25 19:07:11 |
2019-11-25 19:07:11 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:07:11 | ------------------------------------ 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Connector state changed: null->connecting 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] DNS entry stored in session object: missing:5222 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Preparing connection to [missing:5222] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] missing. Trying next. 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Connector state changed: connecting->disconnected 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: null->connecting 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] DNS entry stored in session object: localhost:5222 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Preparing connection to [localhost:5222] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: connecting->connected 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Whitespace ping period is setted to nullms 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><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> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3908] Start TLS 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3912] Proceeding TLS 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3912] Start handshake 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzRwMGJmNTA1Mzcscj1uRTRYNE9wWTFHOTZNQ05aRVpiQw==</auth> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uRTRYNE9wWTFHOTZNQ05aRVpiQ2Jwd28zUWdYa3owY2tLUW1DbnhmLHM9SlFQRlhzR0l0TU93Snc9PSxpPTQwOTY=</challenge> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkU0WDRPcFkxRzk2TUNOWkVaYkNicHdvM1FnWGt6MGNrS1FtQ254ZixwPWM3ZFNsb3ZnOEdHdmRtZDNNb0tKbEI5cndLZm9jTld1Y2VrZHlxRUJVOUU9</response> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VME9tdFNaeHBHa2NQVkx2NUNqWU9KMXkrNXlzMDJCbGJtREw3VlI2Z04wPQ==</success> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost >> <iq xmlns="jabber:client" id="hbOq5EnS13iQaujLAwdsk4b" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost << <iq id="hbOq5EnS13iQaujLAwdsk4b" type="result" xmlns="jabber:client" to="jaxmpp__4p0bf50537@localhost/993927746-tigase-298"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__4p0bf50537@localhost/993927746-tigase-298</jid></bind></iq> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 >> <iq xmlns="jabber:client" id="E8DX5fx4dSM2wh29q7fGCIA" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 << <iq id="E8DX5fx4dSM2wh29q7fGCIA" type="result" xmlns="jabber:client" to="jaxmpp__4p0bf50537@localhost/993927746-tigase-298"/> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 >> <iq to="localhost" id="LbKSeU3AfCv1eIUYhHsgHqg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 >> <iq id="zaF6fJQ6xfzbmN26GORct4p" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 << <enabled location="d4270859fb27" id="16ee64ca-0534-42de-b09b-82bb2c5def7d" max="60" xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 << <iq from="localhost" id="LbKSeU3AfCv1eIUYhHsgHqg" type="result" xmlns="jabber:client" to="jaxmpp__4p0bf50537@localhost/993927746-tigase-298"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10580/f55efd39" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 << <iq id="zaF6fJQ6xfzbmN26GORct4p" type="result" xmlns="jabber:client" to="jaxmpp__4p0bf50537@localhost/993927746-tigase-298"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: connected->disconnecting 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Terminating XMPP Stream 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__4p0bf50537@localhost/993927746-tigase-298 << <presence from="jaxmpp__4p0bf50537@localhost/993927746-tigase-298" xmlns="jabber:client" to="jaxmpp__4p0bf50537@localhost"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp"/></presence> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3912] Connector state changed: disconnecting->disconnected 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
testStateAfterConnectionFailureWebSocket | 0.357s |
2019-11-25 19:07:11 |
2019-11-25 19:07:11 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-25 19:07:11 | ------------------------------------ 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><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> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX215bGF3OTA1Mzgscj1Xb0E1alByRlBTUGZHZUcxcVJiMw==</auth> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Xb0E1alByRlBTUGZHZUcxcVJiM25BWDNxY09hcklkZzh6dlhxYUtKLHM9a0lyVHZnN1Y3RkJrNWc9PSxpPTQwOTY=</challenge> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V29BNWpQckZQU1BmR2VHMXFSYjNuQVgzcWNPYXJJZGc4enZYcWFLSixwPUpsc3o4VWpXcXdxRTJwdGZPZlZRVUdoS0RGS3JZTGJPSEc4T25qUU1GeVk9</response> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0xQzd2dzBrTkRnQnJsZFlQMUJpTjFDYnJzcXhQUzFYM0laRURJYnNTSXhVPQ==</success> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="bt2mj6vq9J3s6VE0/7D8Mo0TIoU=" node="https://tigase.net/tigase-xmpp-server"/></features> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost >> <iq xmlns="jabber:client" id="t9ut0mTO2u1hWiV17hybOEM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost << <iq id="t9ut0mTO2u1hWiV17hybOEM" type="result" xmlns="jabber:client" to="jaxmpp__mylaw90538@localhost/993927746-tigase-299"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__mylaw90538@localhost/993927746-tigase-299</jid></bind></iq> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 >> <iq xmlns="jabber:client" id="EfKbx9lGrkGQ8vu3eJt8wwc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 << <iq id="EfKbx9lGrkGQ8vu3eJt8wwc" type="result" xmlns="jabber:client" to="jaxmpp__mylaw90538@localhost/993927746-tigase-299"/> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 >> <iq to="localhost" id="p25M2eNJwoXWi03l4yr3bpO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 >> <iq id="wdAHqgWV5ywnVVTMDIsoeHS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-25 19:07:11 | jaxmpp_ :: jaxmpp__mylaw90538@localhost/993927746-tigase-299 << <enabled location="d4270859fb27" id="0baa86ba-f226-4f50-a758-1fa1aa434df8" max="60" xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-25 19:07:11 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-25 19:07:11 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |