Test duration: 64.821s
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 20.510s |
2020-02-02 19:27:54 |
2020-02-02 19:27:54 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:27:54 | ------------------------------------ 2020-02-02 19:27:54 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:27:54 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:27:54 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-02-02 19:27:54 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:14 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:14 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX24zMDlhOTA1NTEscj1jNVd4dFh6WTRkdHFsNWF1N1NqNQ==</auth> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jNVd4dFh6WTRkdHFsNWF1N1NqNTBFQU5lQ1d2OGZTbFRDbUhqREtPLHM9TFVHU256WFhTUzdwNWc9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YzVXeHRYelk0ZHRxbDVhdTdTajUwRUFOZUNXdjhmU2xUQ21IakRLTyxwPXpVdUZYbzNRVFBWTFg0WlVKc3RaZWt3K3AvajRkY3FXRUFsRU1RanhRejg9</response> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1wemZxMU03c3RjUnJ3OUl2eTNVWHp4OUVaYmZnRnhBdEpzSktmU3N5TzRJPQ==</success> 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:14 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost >> <iq xmlns="jabber:client" id="KrWfZ9p8sbBByr3nfEykLxv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost >> <iq xmlns="jabber:client" id="MyfZ5uaBrhU9tdV0gKBdR09" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost >> <iq xmlns="jabber:client" id="ntYCzjThIGAhzzqZkW8ISTQ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-309" id="KrWfZ9p8sbBByr3nfEykLxv"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n309a90551@localhost/943755961-tigase-309</jid></bind></iq> 2020-02-02 19:28:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-309 >> <iq to="localhost" id="0c7zzqZkW8ISTQTP39NLDAm" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-309 >> <iq id="GfeQTP39NLDAmZdP0lRZt6s" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-309 << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-310" id="MyfZ5uaBrhU9tdV0gKBdR09"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n309a90551@localhost/943755961-tigase-310</jid></bind></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-310 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-310 >> <iq to="localhost" id="JaXDj7pVawjR7AvbDLGCs13" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-310 >> <iq id="OfaY8xj1o7p5FueGtXlY5wk" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-310 << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-311" id="ntYCzjThIGAhzzqZkW8ISTQ"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__n309a90551@localhost/943755961-tigase-311</jid></bind></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-310 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:14 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 >> <iq to="localhost" id="aihW5dPHTX1mU5pdMTXbRS0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 >> <iq id="4jigOScQPIDj15Fv7yiRXjY" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-311" id="GfeQTP39NLDAmZdP0lRZt6s"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-311" from="localhost" id="0c7zzqZkW8ISTQTP39NLDAm"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:14 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 << <presence xmlns="jabber:client" to="jaxmpp__n309a90551@localhost" from="jaxmpp__n309a90551@localhost/943755961-tigase-311"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-02-02 19:28:15 | jaxmpp_ :: jaxmpp__n309a90551@localhost/943755961-tigase-311 << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-311" from="localhost" id="JaXDj7pVawjR7AvbDLGCs13"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:15 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2020-02-02 19:28:15 | jaxmpp_ :: jaxmpp__n309a90551@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__n309a90551@localhost/943755961-tigase-311" id="OfaY8xj1o7p5FueGtXlY5wk"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
| testStateAfterAuthTimeoutSocket | 20.285s |
2020-02-02 19:28:15 |
2020-02-02 19:28:15 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:28:15 | ------------------------------------ 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Connector state changed: null->connecting 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] DNS entry stored in session object: localhost:5222 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Preparing connection to [localhost:5222] 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Connector state changed: connecting->connected 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=1] Whitespace ping period is setted to nullms 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:15 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4044] Start TLS 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4046] Proceeding TLS 2020-02-02 19:28:15 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4046] Start handshake 2020-02-02 19:28:15 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-02-02 19:28:15 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:15 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4046] Connector state changed: connected->disconnected 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=624 thread=4046] Stream terminated 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector state changed: null->connecting 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] DNS entry stored in session object: localhost:5222 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Preparing connection to [localhost:5222] 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector state changed: connecting->connected 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Whitespace ping period is setted to nullms 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4044] Start TLS 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4051] Proceeding TLS 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4051] Start handshake 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3FjanEybDA1NTIscj0zcnZIcEZ6S0pLUWxYRTRrMU9ubA==</auth> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zcnZIcEZ6S0pLUWxYRTRrMU9ubFJRWElicGVFYklNWTdXS2hWaUFvLHM9UVhDSUFkbHk3VnpLWGc9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M3J2SHBGektKS1FsWEU0azFPbmxSUVhJYnBlRWJJTVk3V0toVmlBbyxwPTl1cFVJOHZ6OWJCU09nd0Z0a3BXb0YwNS94ZWtZVWlQOFYwODBTanl5Y2c9</response> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13cHd5VTcwejlMbGg0N1lreDJnYmFISXA1a2JwcWZtUHJXZ2JSYW9yclhVPQ==</success> 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <iq xmlns="jabber:client" id="0lgR9AjYeIScx8tZnN5lNU0" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <iq xmlns="jabber:client" id="muF3sfFBHymWZZp6l2mYoeB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost >> <iq xmlns="jabber:client" id="Jj6VThJzs6tbLS5lXpYcClH" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-312" id="0lgR9AjYeIScx8tZnN5lNU0"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qcjq2l0552@localhost/943755961-tigase-312</jid></bind></iq> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-312 >> <iq xmlns="jabber:client" id="MMtrZiMPTbILHFPOSY37FCn" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-312 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-313" id="muF3sfFBHymWZZp6l2mYoeB"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qcjq2l0552@localhost/943755961-tigase-313</jid></bind></iq> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-313 >> <iq xmlns="jabber:client" id="Ll85lNU0hNZkZ9zDq6qXVhQ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-313 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="Jj6VThJzs6tbLS5lXpYcClH"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__qcjq2l0552@localhost/943755961-tigase-314</jid></bind></iq> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq xmlns="jabber:client" id="yKjeByo2wu7iNDFnfFrcAr7" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="MMtrZiMPTbILHFPOSY37FCn"/> 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq to="localhost" id="Lna9t3q2lVfQ1dHTW8u5bNS" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="Ll85lNU0hNZkZ9zDq6qXVhQ"/> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <enabled location="2938d31d0913" xmlns="urn:xmpp:sm:3" max="60" id="63d82e6c-baf5-4792-ab0a-901c305215c5" resume="true"/> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq id="isnoYdFJOX5rnU4mPFLOLS2" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="yKjeByo2wu7iNDFnfFrcAr7"/> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq to="localhost" id="1n6Xcxq8wuqZ2hBBfZ9p8sb" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq to="localhost" id="YSzCucv1teByo2wu7iNDFnf" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq id="bsh5dPHTX1mU5pdMTXbRS0e" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" from="localhost" id="Lna9t3q2lVfQ1dHTW8u5bNS"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <iq id="qADRdAq4fvratiS0smRMLzx" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="isnoYdFJOX5rnU4mPFLOLS2"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" from="localhost" id="1n6Xcxq8wuqZ2hBBfZ9p8sb"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Connector state changed: connected->disconnecting 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=1] Terminating XMPP Stream 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4051] Connector state changed: disconnecting->disconnected 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=625 thread=4051] Stream terminated 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <presence xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost" from="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" from="localhost" id="YSzCucv1teByo2wu7iNDFnf"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="bsh5dPHTX1mU5pdMTXbRS0e"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <iq type="result" xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314" id="qADRdAq4fvratiS0smRMLzx"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__qcjq2l0552@localhost/943755961-tigase-314 << <presence xmlns="jabber:client" to="jaxmpp__qcjq2l0552@localhost" from="jaxmpp__qcjq2l0552@localhost/943755961-tigase-314"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterAuthTimeoutWebSocket | 20.407s |
2020-02-02 19:28:35 |
2020-02-02 19:28:35 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:28:35 | ------------------------------------ 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:35 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-02-02 19:28:35 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-02-02 19:28:35 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:55 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-02-02 19:28:55 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:55 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX25tZml6bjA1NTMscj1vdTNQYnNzVkZJSUgxQTc2cHRZRQ==</auth> 2020-02-02 19:28:55 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vdTNQYnNzVkZJSUgxQTc2cHRZRWhUazBLYWtiZHdQQTJzRXZ0M0FuLHM9QUxBY3dTQnRtR2sxK0E9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:55 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3UzUGJzc1ZGSUlIMUE3NnB0WUVoVGswS2FrYmR3UEEyc0V2dDNBbixwPXM2bytPU0wwd0hVSUpQNldVNUVnbTdQNXlLVk1QekxLVEFvem1GZ3BmaUU9</response> 2020-02-02 19:28:55 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1aUnN5WWFMaFBGN0dxT2lQNTJSL0E3ZzV4ck16T3FnUXIrS3cyeGNDOGVFPQ==</success> 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:55 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost >> <iq xmlns="jabber:client" id="zL2xq8wuqZ2hBBfZ9p8sbBB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost >> <iq xmlns="jabber:client" id="iBwGynZn6xfL1cEw9j3oVcG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost >> <iq xmlns="jabber:client" id="DLYISTQTP39NLDAmZdP0lRZ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__nmfizn0553@localhost/943755961-tigase-315" id="zL2xq8wuqZ2hBBfZ9p8sbBB"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nmfizn0553@localhost/943755961-tigase-315</jid></bind></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__nmfizn0553@localhost/943755961-tigase-316" id="iBwGynZn6xfL1cEw9j3oVcG"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nmfizn0553@localhost/943755961-tigase-316</jid></bind></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__nmfizn0553@localhost/943755961-tigase-317" id="DLYISTQTP39NLDAmZdP0lRZ"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__nmfizn0553@localhost/943755961-tigase-317</jid></bind></iq> 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost/943755961-tigase-317 >> <iq xmlns="jabber:client" id="3O5DCwi2wbq39HrnVXeEzn9" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost/943755961-tigase-317 >> <iq xmlns="jabber:client" id="NILXeEzn9EDr9NKKIx5Bu7A" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__nmfizn0553@localhost/943755961-tigase-317 >> <iq xmlns="jabber:client" id="3Q7HKMO4AjGzbLzDrZiMPTb" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-02-02 19:28:59 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterConnectionFailureBosh | 0.774s |
2020-02-02 19:28:56 |
2020-02-02 19:28:56 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:28:56 | ------------------------------------ 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:56 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__1bjr480554@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__1bjr480554@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzFianI0ODA1NTQscj0ycUVpWWhGOWJ6SFlUR1YycE9MRA==</auth> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__1bjr480554@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0ycUVpWWhGOWJ6SFlUR1YycE9MRGxVTEdtUk14bFdJU25yQlpPdkNuLHM9enFDeFFZd05OVTZLb1E9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__1bjr480554@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MnFFaVloRjliekhZVEdWMnBPTERsVUxHbVJNeGxXSVNuckJaT3ZDbixwPW9yQ0xmUE01Y0hPYWJVS0NzNGJMcFgwMEgyaitXMXJqSFdRcXFla3QxS289</response> 2020-02-02 19:28:56 | jaxmpp_ :: jaxmpp__1bjr480554@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1GNVdZU2pzdEdiNFJqWVVnTml1aEtIRGdVUE02ZndzSGdpSjhmT0w1T0ZVPQ==</success> 2020-02-02 19:28:56 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost >> <iq xmlns="jabber:client" id="aLKSXXjFPPLQS1hXgRT3BmY" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__1bjr480554@localhost/943755961-tigase-318" id="aLKSXXjFPPLQS1hXgRT3BmY"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__1bjr480554@localhost/943755961-tigase-318</jid></bind></iq> 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost/943755961-tigase-318 >> <iq to="localhost" id="lU9R7AvbDLGCs13xmR4q6EK" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost/943755961-tigase-318 >> <iq id="y5EUXgOScQPIDj15Fv7yiRX" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost/943755961-tigase-318 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__1bjr480554@localhost/943755961-tigase-318 << <iq type="result" xmlns="jabber:client" to="jaxmpp__1bjr480554@localhost/943755961-tigase-318" id="y5EUXgOScQPIDj15Fv7yiRX"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureSocket | 0.281s |
2020-02-02 19:28:57 |
2020-02-02 19:28:57 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:28:57 | ------------------------------------ 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector state changed: null->connecting 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] DNS entry stored in session object: missing:5222 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Preparing connection to [missing:5222] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] missing. Trying next. 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector state changed: connecting->disconnected 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: null->connecting 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] DNS entry stored in session object: localhost:5222 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Preparing connection to [localhost:5222] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: connecting->connected 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Whitespace ping period is setted to nullms 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4106] Start TLS 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4110] Proceeding TLS 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4110] Start handshake 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3JudTliNzA1NTUscj1Sd1RBWVFDNGo0RUx0aGhLUUptdg==</auth> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Sd1RBWVFDNGo0RUx0aGhLUUptdnNVUjJnb1l6SlFGNVhISkNWU3IxLHM9MHZ3UlpwaTkrSldsaXc9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UndUQVlRQzRqNEVMdGhoS1FKbXZzVVIyZ29ZekpRRjVYSEpDVlNyMSxwPTM1Y2RTQzFlY05ualI1NSsyN056WnZHdnZsN2wzUS9MeDVyTjhDU0JmNjg9</response> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1pZUVUZjc5MUR6eExtSFYydzhHLys0VTlsaUREMytlay9TbCszUXBLT3VBPQ==</success> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost >> <iq xmlns="jabber:client" id="qTWtr2kSRJT4hU6smat0dtl" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__rnu9b70555@localhost/943755961-tigase-319" id="qTWtr2kSRJT4hU6smat0dtl"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__rnu9b70555@localhost/943755961-tigase-319</jid></bind></iq> 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 >> <iq xmlns="jabber:client" id="seVkU2bnbEreKKWkNEv3v3B" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 << <iq type="result" xmlns="jabber:client" to="jaxmpp__rnu9b70555@localhost/943755961-tigase-319" id="seVkU2bnbEreKKWkNEv3v3B"/> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 >> <iq to="localhost" id="HODNDFnfFrcAr7DCzjThIGA" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 << <enabled location="2938d31d0913" xmlns="urn:xmpp:sm:3" max="60" id="5c2ee4e4-e96e-46ae-8ccf-c892192fe971" resume="true"/> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 >> <iq id="ggXpVawjR7AvbDLGCs13xmR" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 << <iq type="result" xmlns="jabber:client" to="jaxmpp__rnu9b70555@localhost/943755961-tigase-319" from="localhost" id="HODNDFnfFrcAr7DCzjThIGA"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10681/8871f720"/><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="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp: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-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 << <iq type="result" xmlns="jabber:client" to="jaxmpp__rnu9b70555@localhost/943755961-tigase-319" id="ggXpVawjR7AvbDLGCs13xmR"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: connected->disconnecting 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Terminating XMPP Stream 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4110] Connector state changed: disconnecting->disconnected 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__rnu9b70555@localhost/943755961-tigase-319 << <presence xmlns="jabber:client" to="jaxmpp__rnu9b70555@localhost" from="jaxmpp__rnu9b70555@localhost/943755961-tigase-319"><c hash="sha-1" xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureWebSocket | 0.339s |
2020-02-02 19:28:57 |
2020-02-02 19:28:57 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-02-02 19:28:57 | ------------------------------------ 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session, stream] 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-02-02 19:28:57 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__587tme0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><register xmlns="http://jabber.org/features/iq-register"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-02-02 19:28:57 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-02-02 19:28:57 | jaxmpp_ :: jaxmpp__587tme0556@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzU4N3RtZTA1NTYscj1aZUJKTU1uUGpHZVRJbk4zazJlUg==</auth> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1aZUJKTU1uUGpHZVRJbk4zazJlUlFyOWs1MThTZnJlWXBrQWJVc3lYLHM9NXQ2UHVCSmg1K3ZNZ0E9PSxpPTQwOTY=</challenge> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WmVCSk1NblBqR2VUSW5OM2syZVJRcjlrNTE4U2ZyZVlwa0FiVXN5WCxwPWg3bDZhMHFWL3RDeXVZZGg3SzRjQ0FLQUdyTWpMSjBNREFBaEZXL1RTdkE9</response> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj15MGF1eDl0cEE3VW56ek42MWJwNmhuQkw4YW9vS0YwUTZvZHdOc1RnZHpFPQ==</success> 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server" ver="yt/8cr6m9n1ChnOxdd/LpFEa8gQ="/></features> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost >> <iq xmlns="jabber:client" id="k16NP3sfFBHymWZZp6l2mYo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost << <iq type="result" xmlns="jabber:client" to="jaxmpp__587tme0556@localhost/943755961-tigase-320" id="k16NP3sfFBHymWZZp6l2mYo"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__587tme0556@localhost/943755961-tigase-320</jid></bind></iq> 2020-02-02 19:28:58 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 >> <iq xmlns="jabber:client" id="iXSoYdFJOX5rnU4mPFLOLS2" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 << <iq type="result" xmlns="jabber:client" to="jaxmpp__587tme0556@localhost/943755961-tigase-320" id="iXSoYdFJOX5rnU4mPFLOLS2"/> 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 >> <iq to="localhost" id="S6hhU9tdV0gKBdR09EAqi2d" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 >> <iq id="G10oZ1rVlRPY8xj1o7p5Fue" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-02-02 19:28:58 | jaxmpp_ :: jaxmpp__587tme0556@localhost/943755961-tigase-320 << <enabled location="2938d31d0913" xmlns="urn:xmpp:sm:3" max="60" id="7c12c56c-1a12-43a6-8d9b-b89f7089fc49" resume="true"/> 2020-02-02 19:28:58 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-02-02 19:28:58 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |