Test duration: 64.640s
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 20.585s |
2019-11-26 19:22:15 |
2019-11-26 19:22:15 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:22:15 | ------------------------------------ 2019-11-26 19:22:15 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:22:15 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:22:15 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-26 19:22:15 | jaxmpp_ :: jaxmpp__lzk4se0533@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-26 19:22:35 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-26 19:22:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:22:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:22:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-26 19:22:35 | jaxmpp_ :: jaxmpp__lzk4se0533@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-26 19:22:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:22:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:22:35 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2x6azRzZTA1MzMscj1aN3RubWRBbDN1VFZZWldVUnFlNA==</auth> 2019-11-26 19:22:35 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aN3RubWRBbDN1VFZZWldVUnFlNEU1MkNYcE1zQ1U3WnlySEpLRzBpLHM9NEIwR3plZ3ArVmlHeWc9PSxpPTQwOTY=</challenge> 2019-11-26 19:22:35 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Wjd0bm1kQWwzdVRWWVpXVVJxZTRFNTJDWHBNc0NVN1p5ckhKS0cwaSxwPXdFemorWWhjOStKQ0swa1JjRzJmaUhFOXdpd215eVgwNzlMMkRPL01uWG89</response> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1yNzhoZzg4UDRaZTBMVmt5aGR0T1ltY1dvcit1YXU0N0RUSFl6eWdsa3RNPQ==</success> 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost >> <iq xmlns="jabber:client" id="WkUzuq7jKWbHtavgYazcLKJ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost >> <iq xmlns="jabber:client" id="oSwP7CACv5i2n5fIBsmW7iX" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost >> <iq xmlns="jabber:client" id="B7dYcQU3aHCtcqXZYiAnQGM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost << <iq to="jaxmpp__lzk4se0533@localhost/993927746-tigase-287" id="WkUzuq7jKWbHtavgYazcLKJ" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__lzk4se0533@localhost/993927746-tigase-287</jid></bind></iq> 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-287 >> <iq to="localhost" id="7aktazcLKJIs17eOCrYWi3u" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-287 >> <iq id="HZLgKJIs17eOCrYWi3uk6t1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-287 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-287 << <iq to="jaxmpp__lzk4se0533@localhost/993927746-tigase-288" id="oSwP7CACv5i2n5fIBsmW7iX" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__lzk4se0533@localhost/993927746-tigase-288</jid></bind></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-287 << <iq to="jaxmpp__lzk4se0533@localhost/993927746-tigase-289" id="B7dYcQU3aHCtcqXZYiAnQGM" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__lzk4se0533@localhost/993927746-tigase-289</jid></bind></iq> 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 >> <iq to="localhost" id="siE7v5i2n5fIBsmW7iX8vgy" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 >> <iq to="localhost" id="YjF9zdyyp9nY7uq4nOZcDw4" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 << <iq to="jaxmpp__lzk4se0533@localhost/993927746-tigase-289" id="HZLgKJIs17eOCrYWi3uk6t1" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 >> <iq id="lYCOIqgZm4ArX2wl17s5qiO" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 << <presence from="jaxmpp__lzk4se0533@localhost/993927746-tigase-289" to="jaxmpp__lzk4se0533@localhost" xmlns="jabber:client"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 >> <iq id="44SlRYo0fytazoOJx4uY9oM" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@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-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@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-26 19:22:36 | jaxmpp_ :: jaxmpp__lzk4se0533@localhost/993927746-tigase-289 << <iq from="localhost" to="jaxmpp__lzk4se0533@localhost/993927746-tigase-289" id="YjF9zdyyp9nY7uq4nOZcDw4" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" 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="text-multi"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
| testStateAfterAuthTimeoutSocket | 20.257s |
2019-11-26 19:22:36 |
2019-11-26 19:22:36 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:22:36 | ------------------------------------ 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Connector state changed: null->connecting 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] DNS entry stored in session object: localhost:5222 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Preparing connection to [localhost:5222] 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Connector state changed: connecting->connected 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=1] Whitespace ping period is setted to nullms 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__phf0jy0534@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-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3840] Start TLS 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3842] Proceeding TLS 2019-11-26 19:22:36 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3842] Start handshake 2019-11-26 19:22:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:36 | jaxmpp_ :: jaxmpp__phf0jy0534@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-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3842] Connector state changed: connected->disconnected 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=593 thread=3842] Stream terminated 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: null->connecting 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] DNS entry stored in session object: localhost:5222 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Preparing connection to [localhost:5222] 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: connecting->connected 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Whitespace ping period is setted to nullms 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@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-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3840] Start TLS 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3847] Proceeding TLS 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3847] Start handshake 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@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-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3BoZjBqeTA1MzQscj11VXVRZ2l0emQ2SGRoMDJPa1NWUw==</auth> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11VXVRZ2l0emQ2SGRoMDJPa1NWUzFWUnVudUtXOXB1MFQyU3piZmU3LHM9YkZmRVQzU0YvbVlCR0E9PSxpPTQwOTY=</challenge> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dVV1UWdpdHpkNkhkaDAyT2tTVlMxVlJ1bnVLVzlwdTBUMlN6YmZlNyxwPUxad3hkd0NxZ2gyejVtdldES1NnUVVDTUEwTXYzb1h3dDdUTGV3RHNSbXM9</response> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mQ253czZialBOSllFcXgvWXVzMzFQbHk2TE9qK2lzbjFHWTlneFV0cjlJPQ==</success> 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost >> <iq xmlns="jabber:client" id="Ww7Yi2lLEKNVV4jScCt0nYb" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-290" id="Ww7Yi2lLEKNVV4jScCt0nYb" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__phf0jy0534@localhost/993927746-tigase-290</jid></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 << <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><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 << <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><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <iq xmlns="jabber:client" id="hb4z8CeFqQ6FIM0hDoeLRNO" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <iq xmlns="jabber:client" id="b9WBq5qSRNAw2hEi0tk0sbr" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <iq xmlns="jabber:client" id="Wza4uq7jKWbHtavgYazcLKJ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-290" id="hb4z8CeFqQ6FIM0hDoeLRNO" xmlns="jabber:client" type="result"/> 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <iq to="localhost" id="Ez8QVUbAp4arXUakROCELUa" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 << <enabled location="d4270859fb27" id="4bf6b846-7c19-4465-adcf-bd203a62f79e" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 >> <iq id="4d2EtcQU3aHCtcqXZYiAnQG" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-290 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-291" id="b9WBq5qSRNAw2hEi0tk0sbr" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__phf0jy0534@localhost/993927746-tigase-291</jid></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-291 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-291 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" id="Wza4uq7jKWbHtavgYazcLKJ" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__phf0jy0534@localhost/993927746-tigase-292</jid></bind></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-291 >> <iq xmlns="jabber:client" id="nf6ywvo8IHt4AthDu9yykTQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 >> <iq xmlns="jabber:client" id="VA5Zm4ArX2wl17s5qiORMV4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" id="4d2EtcQU3aHCtcqXZYiAnQG" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Connector state changed: connected->disconnecting 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=1] Terminating XMPP Stream 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 << <iq from="localhost" to="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" id="Ez8QVUbAp4arXUakROCELUa" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" 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="text-multi"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 << <presence from="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" to="jaxmpp__phf0jy0534@localhost" xmlns="jabber:client"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" id="nf6ywvo8IHt4AthDu9yykTQ" xmlns="jabber:client" type="result"/> 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__phf0jy0534@localhost/993927746-tigase-292 << <iq to="jaxmpp__phf0jy0534@localhost/993927746-tigase-292" id="VA5Zm4ArX2wl17s5qiORMV4" xmlns="jabber:client" type="result"/> 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=594 thread=3847] Connector state changed: disconnecting->disconnected 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.eventbus.ThreadSafeEventBus$2.run: 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.eventbus.ThreadSafeEventBus$2.run: 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.eventbus.ThreadSafeEventBus$2.run: 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.eventbus.ThreadSafeEventBus$2.run: 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza |
| testStateAfterAuthTimeoutWebSocket | 20.407s |
2019-11-26 19:22:56 |
2019-11-26 19:22:56 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:22:56 | ------------------------------------ 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-26 19:22:56 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-26 19:22:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:22:56 | jaxmpp_ :: jaxmpp__f7irqz0535@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-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:16 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-26 19:23:16 | jaxmpp_ :: jaxmpp__f7irqz0535@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-26 19:23:16 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:23:16 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:23:16 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2Y3aXJxejA1MzUscj1VOUF1V0RFVkZuZlRFeFdpSEhLZw==</auth> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1VOUF1V0RFVkZuZlRFeFdpSEhLZ1U3MVVPbUZ4cUhPa3kybW00VG84LHM9dXFuWU9zU3UrcGd1Q0E9PSxpPTQwOTY=</challenge> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VTlBdVdERVZGbmZURXhXaUhIS2dVNzFVT21GeHFIT2t5Mm1tNFRvOCxwPUZId2FsR2YvODNsUk9vWENoWnBYa2ZzS3lkUWd6MmFaYldqSk44QzZqZk09</response> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0xN2lVNTF2TzRPbzRtWHF4bjZOVzZkQUxJRTZwK29ZRnIraXY4YXNBSlgwPQ==</success> 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost >> <iq xmlns="jabber:client" id="qJko8IHt4AthDu9yykTQ3kT" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost >> <iq xmlns="jabber:client" id="ZJidv8IJNFyhO4mXYjQV6ez" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost >> <iq xmlns="jabber:client" id="BwDNQ8udulU3mKBhysU18gW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-293" id="qJko8IHt4AthDu9yykTQ3kT" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f7irqz0535@localhost/993927746-tigase-293</jid></bind></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-294" id="ZJidv8IJNFyhO4mXYjQV6ez" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f7irqz0535@localhost/993927746-tigase-294</jid></bind></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-295" id="BwDNQ8udulU3mKBhysU18gW" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__f7irqz0535@localhost/993927746-tigase-295</jid></bind></iq> 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-293 >> <iq xmlns="jabber:client" id="yCTt1gHEKIFo9whOEpTMUOP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-294 >> <iq xmlns="jabber:client" id="nqhUeVeO4pTUgPZ3kPUgKJw" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq xmlns="jabber:client" id="Pl0Iq3cocR6yynPM0jXZczo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-295" id="yCTt1gHEKIFo9whOEpTMUOP" xmlns="jabber:client" type="result"/> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-295" id="nqhUeVeO4pTUgPZ3kPUgKJw" xmlns="jabber:client" type="result"/> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 << <iq to="jaxmpp__f7irqz0535@localhost/993927746-tigase-295" id="Pl0Iq3cocR6yynPM0jXZczo" xmlns="jabber:client" type="result"/> 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq to="localhost" id="dAHZeu5fukEv6cO5ysmZ3eU" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq to="localhost" id="5BIXaMMNEFylWUVVQ24lMyw" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq to="localhost" id="JCJ3mKBhysU18gWl4uq7jKW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq id="6ABO4mXYjQV6ezdqcoZ48GP" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq id="BEL3maylKRW7u07jCAaxak4" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost/993927746-tigase-295 >> <iq id="aGP4veHEkLBcKubsUeVeO4p" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.presence.PresenceModule$3.after: Could not write stanza 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__f7irqz0535@localhost << <enabled location="d4270859fb27" id="3d008396-a16a-4136-819b-d94af3df0359" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> |
| testStateAfterConnectionFailureBosh | 0.772s |
2019-11-26 19:23:17 |
2019-11-26 19:23:17 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:23:17 | ------------------------------------ 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:23:17 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@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-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzk1eWt5bDA1MzYscj1zOUZiNk5lSm8ya1JGS2d1TjE0Zw==</auth> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zOUZiNk5lSm8ya1JGS2d1TjE0Z0hJaHVlY3BDVUR6M09FMVo3U0djLHM9RHdtaElhVklxSnFUR1E9PSxpPTQwOTY=</challenge> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9czlGYjZOZUpvMmtSRktndU4xNGdISWh1ZWNwQ1VEejNPRTFaN1NHYyxwPTFUMGF2U2lZSXVQVFgxUHBleVRBNERWTk5QOWgxazA4L3k5UlpRNWU3OFE9</response> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pT3BlcTI3S2xOdVQ1VWVHcExPY3ZVRHc2U0lDS2pvQWZLTUFSWll6ZmlzPQ==</success> 2019-11-26 19:23:17 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:17 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost >> <iq xmlns="jabber:client" id="8XwCt0nYbCgDlGIq3cocR6y" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost << <iq to="jaxmpp__95ykyl0536@localhost/993927746-tigase-296" id="8XwCt0nYbCgDlGIq3cocR6y" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__95ykyl0536@localhost/993927746-tigase-296</jid></bind></iq> 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost/993927746-tigase-296 >> <iq to="localhost" id="uN0r0sdLBq1i2iPINORYY3b" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__95ykyl0536@localhost/993927746-tigase-296 >> <iq id="LNYkLBcKubsUeVeO4pTUgPZ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__95ykyl0536@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-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureSocket | 0.232s |
2019-11-26 19:23:18 |
2019-11-26 19:23:18 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:23:18 | ------------------------------------ 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Connector state changed: null->connecting 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] DNS entry stored in session object: missing:5222 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Preparing connection to [missing:5222] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] missing. Trying next. 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=598 thread=1] Connector state changed: connecting->disconnected 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: null->connecting 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] DNS entry stored in session object: localhost:5222 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Preparing connection to [localhost:5222] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: connecting->connected 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Whitespace ping period is setted to nullms 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@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-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3899] Start TLS 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3903] Proceeding TLS 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3903] Start handshake 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@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-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2pndnlidTA1Mzcscj00SWxWYmxLSHlMZmY0M1I1bGFSZQ==</auth> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00SWxWYmxLSHlMZmY0M1I1bGFSZUc4UFJhb1JWNXRYcFZvSXpTbzlELHM9VkExdjhDNWRESDdGNmc9PSxpPTQwOTY=</challenge> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NElsVmJsS0h5TGZmNDNSNWxhUmVHOFBSYW9SVjV0WHBWb0l6U285RCxwPU43ZHhKZ0RXSjJhOTNPVkR4SGk0VWNwTVdyd2dtZlBJSEVuM3FJMm9oT0E9</response> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1ma1pDVTJnS2poUWYxaDJSSG9yU29oMGZhUkpJU01OSHBZWnJGVW1EVTBVPQ==</success> 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost >> <iq xmlns="jabber:client" id="cYnkT26jHo8gJy6CHMUgNFs" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost << <iq to="jaxmpp__jgvybu0537@localhost/993927746-tigase-297" id="cYnkT26jHo8gJy6CHMUgNFs" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__jgvybu0537@localhost/993927746-tigase-297</jid></bind></iq> 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 >> <iq xmlns="jabber:client" id="PChgwfAaKXiWkVVYo5v5oXa" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 << <iq to="jaxmpp__jgvybu0537@localhost/993927746-tigase-297" id="PChgwfAaKXiWkVVYo5v5oXa" xmlns="jabber:client" type="result"/> 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 >> <iq to="localhost" id="85ESZ2r6r8iHtWes7kEITaG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 << <enabled location="d4270859fb27" id="50909903-486d-4df9-a8be-e7a15e5f19c8" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 >> <iq id="eT2GoTRIMyjIqgZm4ArX2wl" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 << <iq from="localhost" to="jaxmpp__jgvybu0537@localhost/993927746-tigase-297" id="85ESZ2r6r8iHtWes7kEITaG" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10591/f55efd39" 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="text-multi"><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><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: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="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@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-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 << <iq to="jaxmpp__jgvybu0537@localhost/993927746-tigase-297" id="eT2GoTRIMyjIqgZm4ArX2wl" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Connector state changed: connected->disconnecting 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=1] Terminating XMPP Stream 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__jgvybu0537@localhost/993927746-tigase-297 << <presence from="jaxmpp__jgvybu0537@localhost/993927746-tigase-297" to="jaxmpp__jgvybu0537@localhost" xmlns="jabber:client"><c hash="sha-1" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3903] Connector state changed: disconnecting->disconnected 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=599 thread=3903] Stream terminated 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterConnectionFailureWebSocket | 0.349s |
2019-11-26 19:23:18 |
2019-11-26 19:23:18 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-26 19:23:18 | ------------------------------------ 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-26 19:23:18 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__ch8xjh0538@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-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-26 19:23:18 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2NoOHhqaDA1Mzgscj1ZVmNCaVFRRzBjOGlvajhxek9odQ==</auth> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZVmNCaVFRRzBjOGlvajhxek9odWc2NTlHNlFxNWFlVGFUUWY5bzFRLHM9VmtOSEtBZzZ6SVBkRHc9PSxpPTQwOTY=</challenge> 2019-11-26 19:23:18 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WVZjQmlRUUcwYzhpb2o4cXpPaHVnNjU5RzZRcTVhZVRhVFFmOW8xUSxwPUVHU3E0Y1VUM3Boa0RQa25nWjJDK2svSnBkU3h6eU80T2VhVnRaTTcweTA9</response> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13MkE2OEltanFOcUxIcVFkOTVzclNENENJQWU0cG5FazM0MldMeDdzYlN3PQ==</success> 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@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" ver="BTEL0uZZSv4xXXpA3cLLdyyHkxk=" node="https://tigase.net/tigase-xmpp-server" xmlns="http://jabber.org/protocol/caps"/></features> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost >> <iq xmlns="jabber:client" id="WbMiWkVVYo5v5oXaMMNEFyl" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost << <iq to="jaxmpp__ch8xjh0538@localhost/993927746-tigase-298" id="WbMiWkVVYo5v5oXaMMNEFyl" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ch8xjh0538@localhost/993927746-tigase-298</jid></bind></iq> 2019-11-26 19:23:19 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 >> <iq xmlns="jabber:client" id="LZaIx9iWSX00qj0maBhGOVb" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 << <iq to="jaxmpp__ch8xjh0538@localhost/993927746-tigase-298" id="LZaIx9iWSX00qj0maBhGOVb" xmlns="jabber:client" type="result"/> 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 >> <iq to="localhost" id="CVWuq4nOZcDw4fz8CeFqQ6F" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 >> <iq id="oLqCHMUgNFsm1nPSV6EwhCB" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@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-26 19:23:19 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-26 19:23:19 | jaxmpp_ :: jaxmpp__ch8xjh0538@localhost/993927746-tigase-298 << <enabled location="d4270859fb27" id="90fd6aff-cf0b-4dce-82cf-2ba38b78e2f7" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2019-11-26 19:23:19 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-26 19:23:19 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |