Test duration: 64.742s
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 20.527s |
2019-11-22 19:19:31 |
2019-11-22 19:19:31 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:19:31 | ------------------------------------ 2019-11-22 19:19:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:19:31 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:19:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-22 19:19:31 | jaxmpp_ :: jaxmpp__h3ipub0530@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-22 19:19:51 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@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-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2gzaXB1YjA1MzAscj1tamtsWjNzamFLUFBkaFV5RmJiSg==</auth> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tamtsWjNzamFLUFBkaFV5RmJiSm9aVzkyUUczMVd2OVU5bEVaa2pILHM9Q2liNDRubjVMU1BZbFE9PSxpPTQwOTY=</challenge> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bWprbFozc2phS1BQZGhVeUZiYkpvWlc5MlFHMzFXdjlVOWxFWmtqSCxwPXQwU0dRTVp5czMvQ2RjZm93SDBha3E2dTZvajlnZGFKc1gxTEhJNVJGTHc9</response> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1LMDY2UTF2c2kvdTVWMkVJbm5LbEdveGFRTTJQeTV0SVBzZkJ5algzNlljPQ==</success> 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost >> <iq xmlns="jabber:client" id="i6qDvdINJvlTUTNO5dBBBGx" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost >> <iq xmlns="jabber:client" id="k19S2r15vdybnYpRTbL0bR9" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost >> <iq xmlns="jabber:client" id="jdH0dINJvlTUTNO5dBBBGxz" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost << <iq id="i6qDvdINJvlTUTNO5dBBBGx" type="result" to="jaxmpp__h3ipub0530@localhost/993927746-tigase-288" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__h3ipub0530@localhost/993927746-tigase-288</jid></bind></iq> 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-288 >> <iq to="localhost" id="e9tEGOXkTZgTVT7r05bADjN" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-288 >> <iq id="ZUIOQ9lR7DKFP5iZ6drdLUg" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@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-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-288 << <iq id="k19S2r15vdybnYpRTbL0bR9" type="result" to="jaxmpp__h3ipub0530@localhost/993927746-tigase-289" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__h3ipub0530@localhost/993927746-tigase-289</jid></bind></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-288 << <iq id="jdH0dINJvlTUTNO5dBBBGxz" type="result" to="jaxmpp__h3ipub0530@localhost/993927746-tigase-290" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__h3ipub0530@localhost/993927746-tigase-290</jid></bind></iq> 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <iq to="localhost" id="afHTNBxpcQ1s9viX39Dt4dr" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <iq to="localhost" id="FZTyetXfP2wnazlYjLzt9qV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <iq id="dTzQ1qiVgLJKRRLRVY13k7h" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <iq id="EkQbLEjDBxsm3whLOZ7hTZ6" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2019-11-22 19:19:51 | jaxmpp_ :: jaxmpp__h3ipub0530@localhost/993927746-tigase-290 << <iq id="e9tEGOXkTZgTVT7r05bADjN" type="result" from="localhost" to="jaxmpp__h3ipub0530@localhost/993927746-tigase-290" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-22 19:19:51 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:19:51 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2019-11-22 19:19:51 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
| testStateAfterAuthTimeoutSocket | 20.263s |
2019-11-22 19:19:52 |
2019-11-22 19:19:52 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:19:52 | ------------------------------------ 2019-11-22 19:19:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] Connector state changed: null->connecting 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] Connector state changed: connecting->connected 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:19:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:19:52 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=3825] Start TLS 2019-11-22 19:19:52 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=3827] Proceeding TLS 2019-11-22 19:19:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=3827] Start handshake 2019-11-22 19:19:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:19:52 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=3827] Connector state changed: connected->disconnected 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=590 thread=3827] Stream terminated 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Connector state changed: null->connecting 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Connector state changed: connecting->connected 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=3825] Start TLS 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=3832] Proceeding TLS 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=3832] Start handshake 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2tmenloNjA1MzEscj1Yc2d0UVlZVnZ4cmg3c05KdjBnbA==</auth> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Yc2d0UVlZVnZ4cmg3c05KdjBnbGdlSmo4YnByY1hiR1l3VWVHalozLHM9ZUdiUTMxRjdBVURsMUE9PSxpPTQwOTY=</challenge> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WHNndFFZWVZ2eHJoN3NOSnYwZ2xnZUpqOGJwcmNYYkdZd1VlR2paMyxwPTc1QjBvVkNma2kzcVRSekZrZkNGYzN3SVJuNlRzMDBRc2hRUkNBNm1SSVk9</response> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj16RUFLUWl5RDJkZlhtY3A4M0VmQ3dRL3c2MDROVy9aUmw3eWhpZm1RV2JJPQ==</success> 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <iq xmlns="jabber:client" id="Ds608FsVR3rgYhYbzqdzbHB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <iq xmlns="jabber:client" id="LjD1uj2jPWfDjX7mNBqjFvp" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost << <iq id="Ds608FsVR3rgYhYbzqdzbHB" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-291" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__kfzyh60531@localhost/993927746-tigase-291</jid></bind></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost >> <iq xmlns="jabber:client" id="6aacPMX25bHJQ8BCt9Axdth" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost << <iq id="LjD1uj2jPWfDjX7mNBqjFvp" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-292" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__kfzyh60531@localhost/993927746-tigase-292</jid></bind></iq> 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-292 >> <iq xmlns="jabber:client" id="hs0IQV3o9rVbzgBdELzj1rm" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-292 << <iq id="6aacPMX25bHJQ8BCt9Axdth" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__kfzyh60531@localhost/993927746-tigase-293</jid></bind></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-292 >> <iq xmlns="jabber:client" id="fmH8ILW7raHx7zlOHp2x7pd" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-292 << <iq id="hs0IQV3o9rVbzgBdELzj1rm" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"/> 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq xmlns="jabber:client" id="2dedP8rnbunSLxp9GOXkTZg" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq to="localhost" id="OoJeHBulPHJFsZZcRLHNZs5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="fmH8ILW7raHx7zlOHp2x7pd" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"/> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="2dedP8rnbunSLxp9GOXkTZg" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"/> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq id="rhmctX8JvbLVkP9JAzgx5vl" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <enabled id="4a4c12e6-73cc-4384-8477-3fa14fe2e909" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq to="localhost" id="UebLRVY13k7hJR7IBHPMX25" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="OoJeHBulPHJFsZZcRLHNZs5" type="result" from="localhost" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq to="localhost" id="7BgjKTUPFFFIS5Ap1k1bp9v" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq id="sfaLxi39tl5EtrjKTUPFFFI" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="rhmctX8JvbLVkP9JAzgx5vl" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 >> <iq id="3x0L0bR9qfCfvl1qiVgLJKR" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@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-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="UebLRVY13k7hJR7IBHPMX25" type="result" from="localhost" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=1] Terminating XMPP Stream 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="sfaLxi39tl5EtrjKTUPFFFI" type="result" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__kfzyh60531@localhost/993927746-tigase-293 << <iq id="7BgjKTUPFFFIS5Ap1k1bp9v" type="result" from="localhost" to="jaxmpp__kfzyh60531@localhost/993927746-tigase-293" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=3832] Connector state changed: disconnecting->disconnected 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=591 thread=3832] Stream terminated 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterAuthTimeoutWebSocket | 20.370s |
2019-11-22 19:20:12 |
2019-11-22 19:20:12 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:20:12 | ------------------------------------ 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-22 19:20:12 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-22 19:20:12 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:12 | jaxmpp_ :: jaxmpp__67w42d0532@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-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzY3dzQyZDA1MzIscj00TGJzaHZCTTJzNXViaVE4SlNHVg==</auth> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00TGJzaHZCTTJzNXViaVE4SlNHVnBvdHIwYm1xbmRiRWx4clVHU3BTLHM9V0N3Si84a0pHRVg3eHc9PSxpPTQwOTY=</challenge> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NExic2h2Qk0yczV1YmlROEpTR1Zwb3RyMGJtcW5kYkVseHJVR1NwUyxwPVJvMnlVcm1PV1JEcmtGWGNGc3h3MzVQWUdzRU1qN1VWQnVUUjdqK3cyckk9</response> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1YL0FORDYwNHp5c3Zqa0ZBc1FOcTV0NnBJUFM5a25lZGY4aCtXL2xsOTNvPQ==</success> 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost >> <iq xmlns="jabber:client" id="PC7PR0nTPZbu37snNLVfY7J" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost >> <iq xmlns="jabber:client" id="slgXV4BfFJRczDHwr013rdO" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost >> <iq xmlns="jabber:client" id="NGfbMNNS7nNV3ex5ofxfTbQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost << <iq id="PC7PR0nTPZbu37snNLVfY7J" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-294" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__67w42d0532@localhost/993927746-tigase-294</jid></bind></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost << <iq id="slgXV4BfFJRczDHwr013rdO" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-295" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__67w42d0532@localhost/993927746-tigase-295</jid></bind></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost << <iq id="NGfbMNNS7nNV3ex5ofxfTbQ" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-296" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__67w42d0532@localhost/993927746-tigase-296</jid></bind></iq> 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-295 >> <iq xmlns="jabber:client" id="hHgdQV3o9rVbzgBdELzj1rm" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-295 >> <iq xmlns="jabber:client" id="ZlaHCHr3vpiL1t4xcpPZj0s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq xmlns="jabber:client" id="GG9Mz9DBACzylT4v9l1fCjD" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 << <iq id="hHgdQV3o9rVbzgBdELzj1rm" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-296" xmlns="jabber:client"/> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 << <iq id="ZlaHCHr3vpiL1t4xcpPZj0s" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-296" xmlns="jabber:client"/> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 << <iq id="GG9Mz9DBACzylT4v9l1fCjD" type="result" to="jaxmpp__67w42d0532@localhost/993927746-tigase-296" xmlns="jabber:client"/> 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq to="localhost" id="jId1fMVZ1nX29jQ9lR7DKFP" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq id="iEZKJFCBlJNNIv1gZ1dP3Al" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq to="localhost" id="cl2rdLUgR8vdINJvlTUTNO5" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq id="ourhTZ6hzmbpZn9MJXlO1al" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq to="localhost" id="9upzgx5vl4Avq5n2r15vdyb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 >> <iq id="Uwtl1fCjDurV1rh2fZpWhGn" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@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-22 19:20:32 | jaxmpp_ :: jaxmpp__67w42d0532@localhost/993927746-tigase-296 << <enabled id="131dc589-67af-486b-8108-7ca30a26f7d3" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:20:32 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:32 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected |
| testStateAfterConnectionFailureBosh | 0.747s |
2019-11-22 19:20:33 |
2019-11-22 19:20:33 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:20:33 | ------------------------------------ 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@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-22 19:20:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzMweXJxazA1MzMscj1jSUFudkxON0xKZXdlNTRaOHBZRg==</auth> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jSUFudkxON0xKZXdlNTRaOHBZRk5PZXNUZVFwSjBzcmtxMlZhdURxLHM9bTB5OExFQUVsOWNxZGc9PSxpPTQwOTY=</challenge> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y0lBbnZMTjdMSmV3ZTU0WjhwWUZOT2VzVGVRcEowc3JrcTJWYXVEcSxwPWIwYjQwZHhhbmtPaFJUaFUrRXhQV2w1OUJqaVlRSlpMUVJxaTVDYnNYSEU9</response> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10YVR4M1VnWjNzZzRmMEFYVEFZME1Wa2MzaTExNytyRXE3akNUWUt4UGQ4PQ==</success> 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost >> <iq xmlns="jabber:client" id="us9Sdt7DFON5Bk3etXfP2wn" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost << <iq id="us9Sdt7DFON5Bk3etXfP2wn" type="result" to="jaxmpp__30yrqk0533@localhost/993927746-tigase-297" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__30yrqk0533@localhost/993927746-tigase-297</jid></bind></iq> 2019-11-22 19:20:33 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost/993927746-tigase-297 >> <iq to="localhost" id="ctaHJNYo7ExhQ3fxp1apPSd" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost/993927746-tigase-297 >> <iq id="HBwpPZj0sfU3jUbv3r5iFlU" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@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-22 19:20:33 | jaxmpp_ :: jaxmpp__30yrqk0533@localhost/993927746-tigase-297 << <iq id="HBwpPZj0sfU3jUbv3r5iFlU" type="result" to="jaxmpp__30yrqk0533@localhost/993927746-tigase-297" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:20:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureSocket | 0.253s |
2019-11-22 19:20:34 |
2019-11-22 19:20:34 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:20:34 | ------------------------------------ 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=595 thread=1] Connector state changed: null->connecting 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=595 thread=1] DNS entry stored in session object: missing:5222 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=595 thread=1] Preparing connection to [missing:5222] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=595 thread=1] missing. Trying next. 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=595 thread=1] Connector state changed: connecting->disconnected 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Connector state changed: null->connecting 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] DNS entry stored in session object: localhost:5222 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Preparing connection to [localhost:5222] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Opening connection to localhost/127.0.0.1:5222 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Connector state changed: connecting->connected 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Whitespace ping period is setted to nullms 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@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-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=3887] Start TLS 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=3891] Proceeding TLS 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=3891] Start handshake 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@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-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3ltMmVodDA1MzQscj03dlNiZENLWHJkc2o5NExBMTU4dA==</auth> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03dlNiZENLWHJkc2o5NExBMTU4dEpIYVA2YVU2WmtRZWRwQm9XcGVrLHM9c2Fza0JLaXlNcXVFZlE9PSxpPTQwOTY=</challenge> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3ZTYmRDS1hyZHNqOTRMQTE1OHRKSGFQNmFVNlprUWVkcEJvV3BlayxwPWd0TkNsZlJ1OXBsbitVNC9wd0NrK0lrN0E0dHlTbWhyT2M1b3lZZnFSRGM9</response> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14NXZoMng4bm1XQ282M0U4T01EYjdYSS9KM1NHUzJqSm1ocnQwb1FDb2x3PQ==</success> 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost >> <iq xmlns="jabber:client" id="lKPiX39Dt4dr6FnVfTgHTdy" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost << <iq id="lKPiX39Dt4dr6FnVfTgHTdy" type="result" to="jaxmpp__ym2eht0534@localhost/993927746-tigase-298" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__ym2eht0534@localhost/993927746-tigase-298</jid></bind></iq> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 >> <iq xmlns="jabber:client" id="rLQapPSdt7DFON5Bk3etXfP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 << <iq id="rLQapPSdt7DFON5Bk3etXfP" type="result" to="jaxmpp__ym2eht0534@localhost/993927746-tigase-298" xmlns="jabber:client"/> 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 >> <iq to="localhost" id="PZuzlYjLzt9qVRWlJDFJW3B" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 << <enabled id="94e38b3a-70f3-4f6d-adce-6ab97fff5372" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 >> <iq id="bIDDhT7CGHORV8DpR3jKz9w" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 << <iq id="PZuzlYjLzt9qVRWlJDFJW3B" type="result" from="localhost" to="jaxmpp__ym2eht0534@localhost/993927746-tigase-298" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" category="server" type="im"/><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="vcard-temp"/><feature var="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@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-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 << <iq id="bIDDhT7CGHORV8DpR3jKz9w" type="result" to="jaxmpp__ym2eht0534@localhost/993927746-tigase-298" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Connector state changed: connected->disconnecting 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=1] Terminating XMPP Stream 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__ym2eht0534@localhost/993927746-tigase-298 << <presence from="jaxmpp__ym2eht0534@localhost/993927746-tigase-298" to="jaxmpp__ym2eht0534@localhost" xmlns="jabber:client"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" xmlns="http://jabber.org/protocol/caps"/></presence> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=596 thread=3891] Connector state changed: disconnecting->disconnected 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureWebSocket | 0.305s |
2019-11-22 19:20:34 |
2019-11-22 19:20:34 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2019-11-22 19:20:34 | ------------------------------------ 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@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-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2FhdW5sYjA1MzUscj1YaVNSV0xhUm5GajNFNWE1NVBKTQ==</auth> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YaVNSV0xhUm5GajNFNWE1NVBKTXdWZDQxNHJrWEI3Q2hkZ25MblNQLHM9aVNFdXpabk9CV0FvT1E9PSxpPTQwOTY=</challenge> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WGlTUldMYVJuRmozRTVhNTVQSk13VmQ0MTRya1hCN0NoZGduTG5TUCxwPThEcEprdktJMHJ1bHZ2Z3hweEtxM0hwdkNxTWFjSlU5cmp0SVozdFBmelU9</response> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OVU9VQ0s3Q1dCekNMbDlidkVONXgreFB5L3NLbzdxaUNyQ3JVTjBJMktFPQ==</success> 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@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 node="https://tigase.net/tigase-xmpp-server" ver="vxsZDK3itTHNCC9pNOSKIQZW/14=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost >> <iq xmlns="jabber:client" id="85CIPMz9DBACzylT4v9l1fC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost << <iq id="85CIPMz9DBACzylT4v9l1fC" type="result" to="jaxmpp__aaunlb0535@localhost/993927746-tigase-299" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__aaunlb0535@localhost/993927746-tigase-299</jid></bind></iq> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 >> <iq xmlns="jabber:client" id="f0lqiVgLJKRRLRVY13k7hJR" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 << <iq id="f0lqiVgLJKRRLRVY13k7hJR" type="result" to="jaxmpp__aaunlb0535@localhost/993927746-tigase-299" xmlns="jabber:client"/> 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 >> <iq to="localhost" id="RTYAxdthLEnLKXX5zxyh3xc" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 >> <iq id="L2nuqbMNNS7nNV3ex5ofxfT" type="get"><query xmlns="jabber:iq:roster"/></iq> 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@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-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2019-11-22 19:20:34 | jaxmpp_ :: jaxmpp__aaunlb0535@localhost/993927746-tigase-299 << <enabled id="f4e5d2ef-0630-48bb-82e5-05f513004044" location="d4270859fb27" xmlns="urn:xmpp:sm:3" max="60" resume="true"/> 2019-11-22 19:20:34 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2019-11-22 19:20:34 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2019-11-22 19:20:37 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |