Test Results Report - Testing reconnections

Passed Tests
tigase.tests.jaxmpp.TestReconnections
testMultipleReconnectionsBosh	5.336s	2020-04-30 00:27:21 \| 2020-04-30 00:27:21 \| null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections] 2020-04-30 00:27:21 \| ------------------------------------ 2020-04-30 00:27:21 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:21 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-04-30 00:27:21 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@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> 2020-04-30 00:27:21 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:21 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2hsZjVwZjA1NTEscj02WDJxN3JHN0N1YVZ6M29lTjhwaA==</auth> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02WDJxN3JHN0N1YVZ6M29lTjhwaGZGWGNWYjRQNDgzekhzQktKUjcxLHM9Um1RNEZpKzF4bWtHR3c9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NlgycTdyRzdDdWFWejNvZU44cGhmRlhjVmI0UDQ4M3pIc0JLSlI3MSxwPStoS3gvMWVORWIxdUViWU9vZUpzYVM2MjVTejN1NHM3SlhIS2lvZi9OWU09</response> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zQWNFRU5IaDB4MHhjZXNpZ0JvUTFKRHZkNzdYZjhkajhzNWI2aUVuU2hjPQ==</success> 2020-04-30 00:27:21 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <iq xmlns="jabber:client" id="k3JdqU3aLAcBvt5tk3vq4xo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <iq type="result" id="k3JdqU3aLAcBvt5tk3vq4xo" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301</jid></bind></iq> 2020-04-30 00:27:21 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <iq to="localhost" id="xSa3vpeGLQ7soYdsV8p6j7E" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <iq id="fBjfDydVgw6rWjGoZh1bFIP" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:21 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:22 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <iq type="result" id="fBjfDydVgw6rWjGoZh1bFIP" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:22 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <iq type="result" id="xSa3vpeGLQ7soYdsV8p6j7E" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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> 2020-04-30 00:27:22 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <presence xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost" from="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-04-30 00:27:23 \| tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-04-30 00:27:24 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-04-30 00:27:24 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@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> 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2hsZjVwZjA1NTEscj1xSmFYNUFzc2VkcWJBNXc3aUFRcw==</auth> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xSmFYNUFzc2VkcWJBNXc3aUFRc1RvdFN3QjY2T00xSWNXaDI4emxyLHM9Um1RNEZpKzF4bWtHR3c9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cUphWDVBc3NlZHFiQTV3N2lBUXNUb3RTd0I2Nk9NMUljV2gyOHpscixwPVdEVktNQ2dVRVllTzk2RFdNWlUzQnlPN0tBWkg0UHNPL0hsZGVucktRa009</response> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zRE56QVRyd3Q3U1pRV3IxS004YjREbHN3MW9CSUJXdGJrVlFLSG00a0hVPQ==</success> 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <iq xmlns="jabber:client" id="z0uIQUdKV4Cq7gxmR07JSKy" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <iq type="result" id="z0uIQUdKV4Cq7gxmR07JSKy" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302</jid></bind></iq> 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <iq to="localhost" id="71vFLKY8x6dIzqXpesYbqhC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <iq id="z2wMYaJMZcSW9kFCn2bR8gA" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 << <iq type="result" id="71vFLKY8x6dIzqXpesYbqhC" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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> 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200
testMultipleReconnectionsSocket	4.538s	2020-04-30 00:27:26 \| 2020-04-30 00:27:26 \| null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections] 2020-04-30 00:27:26 \| ------------------------------------ 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: null->connecting 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] DNS entry stored in session object: localhost:5222 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Preparing connection to [localhost:5222] 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: connecting->connected 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Whitespace ping period is setted to nullms 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__9ymg060552@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> 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3970] Start TLS 2020-04-30 00:27:26 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Proceeding TLS 2020-04-30 00:27:26 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Start handshake 2020-04-30 00:27:26 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@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> 2020-04-30 00:27:27 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:27 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl5bWcwNjA1NTIscj1RT2lMN3EyNWpDcFJsZFVlZ2hEdg==</auth> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RT2lMN3EyNWpDcFJsZFVlZ2hEdjdrRERDc1NMampUaHFySHdRcXFkLHM9MFIzRXFCWUo1NlJleXc9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UU9pTDdxMjVqQ3BSbGRVZWdoRHY3a0REQ3NTTGpqVGhxckh3UXFxZCxwPWhPYzhHeVRHeEpxNjRTUSthd1BkVzBsZVluSXlhaUNBRjA0dlhhZXBYR1k9</response> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02eG1aRDFpMmFMU1FHa3FXa2d6WlZTNWIvdENycC9XYUFaN2RXQmdYemxBPQ==</success> 2020-04-30 00:27:27 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <iq xmlns="jabber:client" id="YJtuh1bFIP3wgVaLKY8x6dI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <iq type="result" id="YJtuh1bFIP3wgVaLKY8x6dI" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9ymg060552@localhost/2095755800-tigase-303</jid></bind></iq> 2020-04-30 00:27:27 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq xmlns="jabber:client" id="A7BX8FEJGQS149AjUVl6cs9" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="A7BX8FEJGQS149AjUVl6cs9" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"/> 2020-04-30 00:27:27 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq to="localhost" id="38CYmWhSbAEufw3oV8nfUOG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <enabled id="18ac661b-503b-4cff-a1b4-8fae12c10084" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq id="beShPGn2dIxzy6gLABgyjVj" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="38CYmWhSbAEufw3oV8nfUOG" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="beShPGn2dIxzy6gLABgyjVj" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:27 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <presence xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost" from="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-04-30 00:27:29 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: connected->disconnecting 2020-04-30 00:27:29 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Terminating XMPP Stream 2020-04-30 00:27:29 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-04-30 00:27:29 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-04-30 00:27:29 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Connector state changed: disconnecting->disconnected 2020-04-30 00:27:29 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-04-30 00:27:29 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Connector state changed: null->connecting 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] DNS entry stored in session object: localhost:5222 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Preparing connection to [localhost:5222] 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Connector state changed: connecting->connected 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Whitespace ping period is setted to nullms 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@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> 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3970] Start TLS 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Proceeding TLS 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Start handshake 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@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> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl5bWcwNjA1NTIscj02YkFKVGpVblUwWW9QUUIwcGowaA==</auth> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02YkFKVGpVblUwWW9QUUIwcGowaHlWWHNDWUh6aFpYd0U1Vk01dERtLHM9MFIzRXFCWUo1NlJleXc9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmJBSlRqVW5VMFlvUFFCMHBqMGh5VlhzQ1lIemhaWHdFNVZNNXREbSxwPTBGeDFUTkkwc3FWQlZtUjMybG9XOWlBUVR2NnduWnZsYTRFMkdSKzBqMkk9</response> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Sd2lvdCtrQnNZS1p6b2ZNWmNUNkt6WmJDYU4xaWlxYk03V1dPUUtleWdZPQ==</success> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <iq xmlns="jabber:client" id="YNxCxxdJQ5zyk3qhM2gNCfM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost << <iq type="result" id="YNxCxxdJQ5zyk3qhM2gNCfM" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9ymg060552@localhost/2095755800-tigase-304</jid></bind></iq> 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq xmlns="jabber:client" id="o1bLXYY9BFtfS9HOQ5up2yi" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="o1bLXYY9BFtfS9HOQ5up2yi" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"/> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq to="localhost" id="fOwFtezDGmMNEJw4lZr1l4x" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <enabled id="b2bc1606-3add-4bcd-aecb-0b85db1288d2" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq id="c04Kw3oV8nfUOGBgXYY9BFt" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="fOwFtezDGmMNEJw4lZr1l4x" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="c04Kw3oV8nfUOGBgXYY9BFt" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <presence xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost" from="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Connector state changed: connected->disconnected 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Stream terminated 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted
testMultipleReconnectionsWebSocket	4.591s	2020-04-30 00:27:31 \| 2020-04-30 00:27:31 \| null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections] 2020-04-30 00:27:31 \| ------------------------------------ 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@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> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E2ZnNjOTA1NTMscj1XREZSdlJiQXhmOEg2UlZkSnQwWQ==</auth> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XREZSdlJiQXhmOEg2UlZkSnQwWU1Tc3U5YWNOVVZaZVpQNjZFazJnLHM9dHd2eVlNbUwvbTg5alE9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V0RGUnZSYkF4ZjhINlJWZEp0MFlNU3N1OWFjTlVWWmVaUDY2RWsyZyxwPWp5eEpNZEpremRzYWdNWjExb0JoWGdjb0s2ZkdIVHpoak5hNjZwSW1VME09</response> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1tNU1yY2xsR21yTWlLaFdvVUNIYTRDcnNGUmtMWUdiU3VFZGVQckI3SHlZPQ==</success> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <iq xmlns="jabber:client" id="YUEQZr1l4xtmWhSbAEufw3o" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <iq type="result" id="YUEQZr1l4xtmWhSbAEufw3o" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q6fsc90553@localhost/2095755800-tigase-305</jid></bind></iq> 2020-04-30 00:27:31 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq xmlns="jabber:client" id="7iMdRWmU5cp6lY3BCewhCFo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="7iMdRWmU5cp6lY3BCewhCFo" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"/> 2020-04-30 00:27:31 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq to="localhost" id="SUAznO3amV9LFDEHN0eR2ve" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq id="OdtohYWW7i16eFDJBvobLW6" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:31 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:32 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <enabled id="e981bad3-146b-4340-a40f-314ea30b9744" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2020-04-30 00:27:32 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="SUAznO3amV9LFDEHN0eR2ve" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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> 2020-04-30 00:27:32 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="OdtohYWW7i16eFDJBvobLW6" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:32 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <presence xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost" from="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-04-30 00:27:33 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-04-30 00:27:33 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-04-30 00:27:33 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-04-30 00:27:33 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-04-30 00:27:33 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-04-30 00:27:33 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-04-30 00:27:35 \| tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-04-30 00:27:35 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-04-30 00:27:35 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-04-30 00:27:35 \| tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-04-30 00:27:35 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@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> 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E2ZnNjOTA1NTMscj1KTWNWbnpVUUd4MUhrRE9SRWxkcg==</auth> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KTWNWbnpVUUd4MUhrRE9SRWxkcjdQNGlzcWlkNGtPM2lkSmw4NGd2LHM9dHd2eVlNbUwvbTg5alE9PSxpPTQwOTY=</challenge> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Sk1jVm56VVFHeDFIa0RPUkVsZHI3UDRpc3FpZDRrTzNpZEpsODRndixwPVhSMFlEN2dkUDV0dEs0cjlvb0JzUVBuMWkvdWZFQ3l6Qm1senRycnJjOWM9</response> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1PWG1YQjkxVjlOUVJHZDRBdi9leFBGUDZJSURkVHQyUnJMRi9jRUNZa0RFPQ==</success> 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@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" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <iq xmlns="jabber:client" id="ddrfviJKBHOCiPIRMAn3zhR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <iq type="result" id="ddrfviJKBHOCiPIRMAn3zhR" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-306"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q6fsc90553@localhost/2095755800-tigase-306</jid></bind></iq> 2020-04-30 00:27:36 \| tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq xmlns="jabber:client" id="c9d26dIzqXpesYbqhCgJLZ7" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 << <iq type="result" id="c9d26dIzqXpesYbqhCgJLZ7" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-306"/> 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq to="localhost" id="mYEHDk5eubFNJLUdP4m7yxi" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq id="Ibf6eteBu5FKu2jGNEkR1v9" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2020-04-30 00:27:36 \| jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 << <enabled id="457a5f89-877b-4ad9-9048-585060abf041" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/> 2020-04-30 00:27:36 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-04-30 00:27:36 \| tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-04-30 00:27:36 \| tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

tigase.tests.jaxmpp.TestReconnections

testMultipleReconnectionsBosh

5.336s

2020-04-30 00:27:21 |

2020-04-30 00:27:21 | null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections]

2020-04-30 00:27:21 | ------------------------------------

2020-04-30 00:27:21 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:21 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2020-04-30 00:27:21 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:21 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:21 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2hsZjVwZjA1NTEscj02WDJxN3JHN0N1YVZ6M29lTjhwaA==</auth>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02WDJxN3JHN0N1YVZ6M29lTjhwaGZGWGNWYjRQNDgzekhzQktKUjcxLHM9Um1RNEZpKzF4bWtHR3c9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NlgycTdyRzdDdWFWejNvZU44cGhmRlhjVmI0UDQ4M3pIc0JLSlI3MSxwPStoS3gvMWVORWIxdUViWU9vZUpzYVM2MjVTejN1NHM3SlhIS2lvZi9OWU09</response>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zQWNFRU5IaDB4MHhjZXNpZ0JvUTFKRHZkNzdYZjhkajhzNWI2aUVuU2hjPQ==</success>

2020-04-30 00:27:21 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <iq xmlns="jabber:client" id="k3JdqU3aLAcBvt5tk3vq4xo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <iq type="result" id="k3JdqU3aLAcBvt5tk3vq4xo" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301</jid></bind></iq>

2020-04-30 00:27:21 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <iq to="localhost" id="xSa3vpeGLQ7soYdsV8p6j7E" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <iq id="fBjfDydVgw6rWjGoZh1bFIP" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:21 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:22 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <iq type="result" id="fBjfDydVgw6rWjGoZh1bFIP" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:22 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <iq type="result" id="xSa3vpeGLQ7soYdsV8p6j7E" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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>

2020-04-30 00:27:22 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301 << <presence xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost" from="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-301"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-04-30 00:27:23 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

2020-04-30 00:27:24 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2020-04-30 00:27:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2hsZjVwZjA1NTEscj1xSmFYNUFzc2VkcWJBNXc3aUFRcw==</auth>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xSmFYNUFzc2VkcWJBNXc3aUFRc1RvdFN3QjY2T00xSWNXaDI4emxyLHM9Um1RNEZpKzF4bWtHR3c9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cUphWDVBc3NlZHFiQTV3N2lBUXNUb3RTd0I2Nk9NMUljV2gyOHpscixwPVdEVktNQ2dVRVllTzk2RFdNWlUzQnlPN0tBWkg0UHNPL0hsZGVucktRa009</response>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zRE56QVRyd3Q3U1pRV3IxS004YjREbHN3MW9CSUJXdGJrVlFLSG00a0hVPQ==</success>

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost >> <iq xmlns="jabber:client" id="z0uIQUdKV4Cq7gxmR07JSKy" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost << <iq type="result" id="z0uIQUdKV4Cq7gxmR07JSKy" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302</jid></bind></iq>

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <iq to="localhost" id="71vFLKY8x6dIzqXpesYbqhC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <iq id="z2wMYaJMZcSW9kFCn2bR8gA" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302 << <iq type="result" id="71vFLKY8x6dIzqXpesYbqhC" xmlns="jabber:client" to="jaxmpp__hlf5pf0551@localhost/2095755800-tigase-302" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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>

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200

testMultipleReconnectionsSocket

4.538s

2020-04-30 00:27:26 |

2020-04-30 00:27:26 | null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections]

2020-04-30 00:27:26 | ------------------------------------

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: null->connecting

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] DNS entry stored in session object: localhost:5222

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Preparing connection to [localhost:5222]

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Opening connection to localhost/127.0.0.1:5222

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: connecting->connected

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Whitespace ping period is setted to nullms

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3970] Start TLS

2020-04-30 00:27:26 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Proceeding TLS

2020-04-30 00:27:26 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Start handshake

2020-04-30 00:27:26 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:27 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:27 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl5bWcwNjA1NTIscj1RT2lMN3EyNWpDcFJsZFVlZ2hEdg==</auth>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1RT2lMN3EyNWpDcFJsZFVlZ2hEdjdrRERDc1NMampUaHFySHdRcXFkLHM9MFIzRXFCWUo1NlJleXc9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UU9pTDdxMjVqQ3BSbGRVZWdoRHY3a0REQ3NTTGpqVGhxckh3UXFxZCxwPWhPYzhHeVRHeEpxNjRTUSthd1BkVzBsZVluSXlhaUNBRjA0dlhhZXBYR1k9</response>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02eG1aRDFpMmFMU1FHa3FXa2d6WlZTNWIvdENycC9XYUFaN2RXQmdYemxBPQ==</success>

2020-04-30 00:27:27 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <iq xmlns="jabber:client" id="YJtuh1bFIP3wgVaLKY8x6dI" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <iq type="result" id="YJtuh1bFIP3wgVaLKY8x6dI" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9ymg060552@localhost/2095755800-tigase-303</jid></bind></iq>

2020-04-30 00:27:27 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq xmlns="jabber:client" id="A7BX8FEJGQS149AjUVl6cs9" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="A7BX8FEJGQS149AjUVl6cs9" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"/>

2020-04-30 00:27:27 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq to="localhost" id="38CYmWhSbAEufw3oV8nfUOG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <enabled id="18ac661b-503b-4cff-a1b4-8fae12c10084" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <iq id="beShPGn2dIxzy6gLABgyjVj" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="38CYmWhSbAEufw3oV8nfUOG" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <iq type="result" id="beShPGn2dIxzy6gLABgyjVj" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:27 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-303 << <presence xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost" from="jaxmpp__9ymg060552@localhost/2095755800-tigase-303"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-04-30 00:27:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Connector state changed: connected->disconnecting

2020-04-30 00:27:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=1] Terminating XMPP Stream

2020-04-30 00:27:29 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2020-04-30 00:27:29 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2020-04-30 00:27:29 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=621 thread=3972] Connector state changed: disconnecting->disconnected

2020-04-30 00:27:29 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2020-04-30 00:27:29 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Connector state changed: null->connecting

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] DNS entry stored in session object: localhost:5222

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Preparing connection to [localhost:5222]

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Opening connection to localhost/127.0.0.1:5222

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Connector state changed: connecting->connected

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=1] Whitespace ping period is setted to nullms

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3970] Start TLS

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Proceeding TLS

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Start handshake

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzl5bWcwNjA1NTIscj02YkFKVGpVblUwWW9QUUIwcGowaA==</auth>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02YkFKVGpVblUwWW9QUUIwcGowaHlWWHNDWUh6aFpYd0U1Vk01dERtLHM9MFIzRXFCWUo1NlJleXc9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NmJBSlRqVW5VMFlvUFFCMHBqMGh5VlhzQ1lIemhaWHdFNVZNNXREbSxwPTBGeDFUTkkwc3FWQlZtUjMybG9XOWlBUVR2NnduWnZsYTRFMkdSKzBqMkk9</response>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1Sd2lvdCtrQnNZS1p6b2ZNWmNUNkt6WmJDYU4xaWlxYk03V1dPUUtleWdZPQ==</success>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost >> <iq xmlns="jabber:client" id="YNxCxxdJQ5zyk3qhM2gNCfM" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost << <iq type="result" id="YNxCxxdJQ5zyk3qhM2gNCfM" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__9ymg060552@localhost/2095755800-tigase-304</jid></bind></iq>

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq xmlns="jabber:client" id="o1bLXYY9BFtfS9HOQ5up2yi" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="o1bLXYY9BFtfS9HOQ5up2yi" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"/>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq to="localhost" id="fOwFtezDGmMNEJw4lZr1l4x" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <enabled id="b2bc1606-3add-4bcd-aecb-0b85db1288d2" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <iq id="c04Kw3oV8nfUOGBgXYY9BFt" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="fOwFtezDGmMNEJw4lZr1l4x" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <iq type="result" id="c04Kw3oV8nfUOGBgXYY9BFt" xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__9ymg060552@localhost/2095755800-tigase-304 << <presence xmlns="jabber:client" to="jaxmpp__9ymg060552@localhost" from="jaxmpp__9ymg060552@localhost/2095755800-tigase-304"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Connector state changed: connected->disconnected

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=622 thread=3977] Stream terminated

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

testMultipleReconnectionsWebSocket

4.591s

2020-04-30 00:27:31 |

2020-04-30 00:27:31 | null / [TestClass name=class tigase.tests.jaxmpp.TestReconnections]

2020-04-30 00:27:31 | ------------------------------------

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E2ZnNjOTA1NTMscj1XREZSdlJiQXhmOEg2UlZkSnQwWQ==</auth>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XREZSdlJiQXhmOEg2UlZkSnQwWU1Tc3U5YWNOVVZaZVpQNjZFazJnLHM9dHd2eVlNbUwvbTg5alE9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V0RGUnZSYkF4ZjhINlJWZEp0MFlNU3N1OWFjTlVWWmVaUDY2RWsyZyxwPWp5eEpNZEpremRzYWdNWjExb0JoWGdjb0s2ZkdIVHpoak5hNjZwSW1VME09</response>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1tNU1yY2xsR21yTWlLaFdvVUNIYTRDcnNGUmtMWUdiU3VFZGVQckI3SHlZPQ==</success>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <iq xmlns="jabber:client" id="YUEQZr1l4xtmWhSbAEufw3o" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <iq type="result" id="YUEQZr1l4xtmWhSbAEufw3o" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q6fsc90553@localhost/2095755800-tigase-305</jid></bind></iq>

2020-04-30 00:27:31 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq xmlns="jabber:client" id="7iMdRWmU5cp6lY3BCewhCFo" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="7iMdRWmU5cp6lY3BCewhCFo" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"/>

2020-04-30 00:27:31 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq to="localhost" id="SUAznO3amV9LFDEHN0eR2ve" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <iq id="OdtohYWW7i16eFDJBvobLW6" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:31 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:32 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <enabled id="e981bad3-146b-4340-a40f-314ea30b9744" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2020-04-30 00:27:32 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="SUAznO3amV9LFDEHN0eR2ve" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305" from="localhost"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10714/4086d2cd"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><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:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter: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>

2020-04-30 00:27:32 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <iq type="result" id="OdtohYWW7i16eFDJBvobLW6" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:32 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-305 << <presence xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost" from="jaxmpp__q6fsc90553@localhost/2095755800-tigase-305"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2020-04-30 00:27:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2020-04-30 00:27:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2020-04-30 00:27:33 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2020-04-30 00:27:33 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset.

2020-04-30 00:27:33 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session]

2020-04-30 00:27:33 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2020-04-30 00:27:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream]

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector.

2020-04-30 00:27:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290

2020-04-30 00:27:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected

2020-04-30 00:27:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms

2020-04-30 00:27:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3E2ZnNjOTA1NTMscj1KTWNWbnpVUUd4MUhrRE9SRWxkcg==</auth>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KTWNWbnpVUUd4MUhrRE9SRWxkcjdQNGlzcWlkNGtPM2lkSmw4NGd2LHM9dHd2eVlNbUwvbTg5alE9PSxpPTQwOTY=</challenge>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Sk1jVm56VVFHeDFIa0RPUkVsZHI3UDRpc3FpZDRrTzNpZEpsODRndixwPVhSMFlEN2dkUDV0dEs0cjlvb0JzUVBuMWkvdWZFQ3l6Qm1senRycnJjOWM9</response>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1PWG1YQjkxVjlOUVJHZDRBdi9leFBGUDZJSURkVHQyUnJMRi9jRUNZa0RFPQ==</success>

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@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"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" ver="BK4ezd8/fUCp9Ms2Gs2z6v5XnWU="/></features>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost >> <iq xmlns="jabber:client" id="ddrfviJKBHOCiPIRMAn3zhR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost << <iq type="result" id="ddrfviJKBHOCiPIRMAn3zhR" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-306"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__q6fsc90553@localhost/2095755800-tigase-306</jid></bind></iq>

2020-04-30 00:27:36 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded.

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq xmlns="jabber:client" id="c9d26dIzqXpesYbqhCgJLZ7" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 << <iq type="result" id="c9d26dIzqXpesYbqhCgJLZ7" xmlns="jabber:client" to="jaxmpp__q6fsc90553@localhost/2095755800-tigase-306"/>

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq to="localhost" id="mYEHDk5eubFNJLUdP4m7yxi" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <iq id="Ibf6eteBu5FKu2jGNEkR1v9" type="get"><query xmlns="jabber:iq:roster"/></iq>

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated

2020-04-30 00:27:36 | jaxmpp_ :: jaxmpp__q6fsc90553@localhost/2095755800-tigase-306 << <enabled id="457a5f89-877b-4ad9-9048-585060abf041" location="9585556aacac" xmlns="urn:xmpp:sm:3" resume="true" max="60"/>

2020-04-30 00:27:36 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

2020-04-30 00:27:36 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected

2020-04-30 00:27:36 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted

Testing reconnections - #4266