Test duration: 65.123s
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 20.512s |
2020-03-29 22:50:49 |
2020-03-29 22:50:49 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:50:49 | ------------------------------------ 2020-03-29 22:50:49 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:50:49 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:50:49 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-03-29 22:50:50 | jaxmpp_ :: jaxmpp__hiqkbc0554@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-03-29 22:51:09 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-03-29 22:51:09 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:09 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:09 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@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-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2hpcWtiYzA1NTQscj0xMFZIcjRsVWJYcU1SYkJvNHludA==</auth> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xMFZIcjRsVWJYcU1SYkJvNHludE9oMURoeGpHZE91YlVFOFg1d1c3LHM9N2NWNTJrVTl2SHNQOGc9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MTBWSHI0bFViWHFNUmJCbzR5bnRPaDFEaHhqR2RPdWJVRThYNXdXNyxwPU9NOTN0SVNSUWlXS1ZNd082NGcyNk94c2JkN3VUZWUvUGlSdjRFS3NnTGM9</response> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10QXJwUFFLalZrM0V5cEtmVXpnLzVscVZCTTRPYk0yaUw0dEl5NXozc0k4PQ==</success> 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost >> <iq xmlns="jabber:client" id="JGn8EpbBndMYnVeVj4aAufC" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost >> <iq xmlns="jabber:client" id="sEfQWcFskXm9vhSYgDohCCl" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost >> <iq xmlns="jabber:client" id="0uJUeLYnXbGAu5i5eQNX9tp" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-309" type="result" id="JGn8EpbBndMYnVeVj4aAufC"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hiqkbc0554@localhost/2095755800-tigase-309</jid></bind></iq> 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-309 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310" type="result" id="0uJUeLYnXbGAu5i5eQNX9tp"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310</jid></bind></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-309 >> <iq to="localhost" id="EyTkY3eXYkLT1dT8GNLUh1u" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310 >> <iq id="WIltoOS4pWiTeTZfOQ07mdu" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310 >> <iq to="localhost" id="nHg1qj5CgMS1aKN2vdHIECl" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310 >> <iq id="iwHTfQ6DrgZrkGCynSaDIRV" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" id="sEfQWcFskXm9vhSYgDohCCl"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311</jid></bind></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-310 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" id="WIltoOS4pWiTeTZfOQ07mdu"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" from="localhost" id="EyTkY3eXYkLT1dT8GNLUh1u"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" from="localhost" id="nHg1qj5CgMS1aKN2vdHIECl"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 >> <iq to="localhost" id="4Klr5rcCydyBgUVdFvti0r3" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 >> <iq id="aDYnSfyu5xjN3sk5l4BFMAq" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" id="iwHTfQ6DrgZrkGCynSaDIRV"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <presence xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost" from="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <presence xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost" from="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311 << <iq xmlns="jabber:client" to="jaxmpp__hiqkbc0554@localhost/2095755800-tigase-311" type="result" from="localhost" id="4Klr5rcCydyBgUVdFvti0r3"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 |
| testStateAfterAuthTimeoutSocket | 20.333s |
2020-03-29 22:51:10 |
2020-03-29 22:51:10 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:51:10 | ------------------------------------ 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] Connector state changed: null->connecting 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] DNS entry stored in session object: localhost:5222 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] Preparing connection to [localhost:5222] 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] Connector state changed: connecting->connected 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=1] Whitespace ping period is setted to nullms 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__6g98r80555@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-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=4047] Start TLS 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=4049] Proceeding TLS 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-03-29 22:51:10 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=4049] Start handshake 2020-03-29 22:51:10 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:10 | jaxmpp_ :: jaxmpp__6g98r80555@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-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=4049] Connector state changed: connected->disconnected 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=627 thread=4049] Stream terminated 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Connector state changed: null->connecting 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] DNS entry stored in session object: localhost:5222 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Preparing connection to [localhost:5222] 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Connector state changed: connecting->connected 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Whitespace ping period is setted to nullms 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@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-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=4047] Start TLS 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=4054] Proceeding TLS 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=4054] Start handshake 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@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-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzZnOThyODA1NTUscj1CSHB4eW9lRWtHQk13ejdGb0hIdQ==</auth> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CSHB4eW9lRWtHQk13ejdGb0hIdUlvZ20yZ0gxcnhrM1ltM01HZ2VHLHM9T2xVdnlCcVZWTzU5Y2c9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QkhweHlvZUVrR0JNd3o3Rm9ISHVJb2dtMmdIMXJ4azNZbTNNR2dlRyxwPWUxL2dIR2NlNnV6d0dYdUx5VWl3VkM3eGN4YVE5ZFBNRjhWd1lIb3E4TW89</response> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1kZm1iR1p2ZHhvMEVRT0s4RXFqUG94WUF3L1I5bkkxN01yczJMbkRienIwPQ==</success> 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <iq xmlns="jabber:client" id="5OnhPYaEpWnO07Br3zuodBA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <iq xmlns="jabber:client" id="dTAyu5xjN3sk5l4BFMAqaBk" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-312" type="result" id="5OnhPYaEpWnO07Br3zuodBA"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6g98r80555@localhost/2095755800-tigase-312</jid></bind></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost >> <iq xmlns="jabber:client" id="wGVi0j4zlXeGGt4Dk2bJHzB" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-312 >> <iq xmlns="jabber:client" id="lMb6DrgZrkGCynSaDIRV7yk" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-312 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-313" type="result" id="dTAyu5xjN3sk5l4BFMAqaBk"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6g98r80555@localhost/2095755800-tigase-313</jid></bind></iq> 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-313 >> <iq xmlns="jabber:client" id="oCF2xxw4o6t4ypgX7vkS4fC" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-313 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="wGVi0j4zlXeGGt4Dk2bJHzB"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__6g98r80555@localhost/2095755800-tigase-314</jid></bind></iq> 2020-03-29 22:51:30 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq xmlns="jabber:client" id="ewloT9xfXgWjNYph02kYdyw" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="lMb6DrgZrkGCynSaDIRV7yk"/> 2020-03-29 22:51:30 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq to="localhost" id="fRk5xjN3sk5l4BFMAqaBk4r" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="oCF2xxw4o6t4ypgX7vkS4fC"/> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <enabled location="9585556aacac" max="60" xmlns="urn:xmpp:sm:3" resume="true" id="c195d417-77e3-4dfa-80e0-77914fba3637"/> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq id="pSltpgym2lO2ncPRZiOWZ6H" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="ewloT9xfXgWjNYph02kYdyw"/> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq to="localhost" id="UGJaN3y8wmZ6Cxwt9zs8AhG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq id="LUnbJHzBywt7CHRamYgNIQZ" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" from="localhost" id="fRk5xjN3sk5l4BFMAqaBk4r"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq to="localhost" id="TYxzwvtoOS4pWiTeTZfOQ07" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <iq id="IGD5eQNX9tpaKV1qj5CgMS1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="pSltpgym2lO2ncPRZiOWZ6H"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:30 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" from="localhost" id="UGJaN3y8wmZ6Cxwt9zs8AhG"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Connector state changed: connected->disconnecting 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=1] Terminating XMPP Stream 2020-03-29 22:51:31 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="LUnbJHzBywt7CHRamYgNIQZ"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:31 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <presence xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost" from="jaxmpp__6g98r80555@localhost/2095755800-tigase-314"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-03-29 22:51:31 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" from="localhost" id="TYxzwvtoOS4pWiTeTZfOQ07"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:31 | jaxmpp_ :: jaxmpp__6g98r80555@localhost/2095755800-tigase-314 << <iq xmlns="jabber:client" to="jaxmpp__6g98r80555@localhost/2095755800-tigase-314" type="result" id="IGD5eQNX9tpaKV1qj5CgMS1"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=4054] Connector state changed: disconnecting->disconnected 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=628 thread=4054] Stream terminated 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterAuthTimeoutWebSocket | 20.362s |
2020-03-29 22:51:31 |
2020-03-29 22:51:31 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:51:31 | ------------------------------------ 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-03-29 22:51:31 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-03-29 22:51:31 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:31 | jaxmpp_ :: jaxmpp__p4yxzr0556@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-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@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-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3A0eXh6cjA1NTYscj1BajlsajRXMGg2dmpoRUtiNXljaA==</auth> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BajlsajRXMGg2dmpoRUtiNXljaGwxRlY0aHFPRGFhNVl6cDVvcTZGLHM9RkltSCtrdjNCU1J0YkE9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QWo5bGo0VzBoNnZqaEVLYjV5Y2hsMUZWNGhxT0RhYTVZenA1b3E2RixwPXhpNlg0aVIwVk1KYjNqbi83Y3FqTWF6ZDVSRmNUc3lhbDIrQlF1Ym1SUUU9</response> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1zNHhHakcwdmVHUms2ak0xQjZYazY1TmxMNFFUMjRrTFpkeGhZZjdkT244PQ==</success> 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost >> <iq xmlns="jabber:client" id="cKHdumP1hJVcO3hWl9KwiU5" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost >> <iq xmlns="jabber:client" id="A5G7r9Csezg16AhV5l9EIRT" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost >> <iq xmlns="jabber:client" id="EYjaEpWnO07Br3zuodBADJU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-315" type="result" id="cKHdumP1hJVcO3hWl9KwiU5"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4yxzr0556@localhost/2095755800-tigase-315</jid></bind></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-316" type="result" id="A5G7r9Csezg16AhV5l9EIRT"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4yxzr0556@localhost/2095755800-tigase-316</jid></bind></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317" type="result" id="EYjaEpWnO07Br3zuodBADJU"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317</jid></bind></iq> 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq xmlns="jabber:client" id="aZk5i5eQNX9tpaKV1qj5CgM" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq xmlns="jabber:client" id="Q9MeSbxsndSMOW9qgP6DtdK" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq xmlns="jabber:client" id="s9KQWcFskXm9vhSYgDohCCl" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317" type="result" id="aZk5i5eQNX9tpaKV1qj5CgM"/> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317" type="result" id="Q9MeSbxsndSMOW9qgP6DtdK"/> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 << <iq xmlns="jabber:client" to="jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317" type="result" id="s9KQWcFskXm9vhSYgDohCCl"/> 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq to="localhost" id="gPKbBndMYnVeVj4aAufCEBE" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq id="BaJZfOQ07mdumP1hJVcO3hW" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq to="localhost" id="84pm2but0oT9xfXgWjNYph0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq to="localhost" id="f9CFHDrl2upZmbP6eIKLEIJ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq id="86rqar0v4w9Fzj5wslR6FN2" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <iq id="oY1KXncq6wjKU7GNNR2iUVY" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost/2095755800-tigase-317 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-03-29 22:51:51 | jaxmpp_ :: jaxmpp__p4yxzr0556@localhost << <enabled location="9585556aacac" max="60" xmlns="urn:xmpp:sm:3" resume="true" id="55487dec-4fd2-4500-8e23-7b964e1c9c16"/> 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected |
| testStateAfterConnectionFailureBosh | 0.742s |
2020-03-29 22:51:51 |
2020-03-29 22:51:51 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:51:51 | ------------------------------------ 2020-03-29 22:51:51 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:51:51 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@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-03-29 22:51:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzhoOHk5YTA1NTcscj1NU2QxN1owblJRdDZCbGVjM1dFWg==</auth> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NU2QxN1owblJRdDZCbGVjM1dFWm9Md2VtcXlFN2dmQzZHZk5oVUN3LHM9TWsyV3pyb2FPdFNmK3c9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TVNkMTdaMG5SUXQ2QmxlYzNXRVpvTHdlbXF5RTdnZkM2R2ZOaFVDdyxwPUE5bXZYU3g1K1A4bGhZNEwwTktLcjRxaWpDM3N6WGw4V0Y0RHZ6TERBWUk9</response> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1qSS9va3ZoMnluS1A2enBhc0pTWTZiVU5FVGVSMmdmc1ltcGFBMExLM2NrPQ==</success> 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost >> <iq xmlns="jabber:client" id="O6h3zuodBADJUQWcFskXm9v" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost << <iq xmlns="jabber:client" to="jaxmpp__8h8y9a0557@localhost/2095755800-tigase-318" type="result" id="O6h3zuodBADJUQWcFskXm9v"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__8h8y9a0557@localhost/2095755800-tigase-318</jid></bind></iq> 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost/2095755800-tigase-318 >> <iq to="localhost" id="yiPh0r5rcCydyBgUVdFvti0" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost/2095755800-tigase-318 >> <iq id="EdyEClO7iY3tbxxqgX5yzBE" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:52 | jaxmpp_ :: jaxmpp__8h8y9a0557@localhost/2095755800-tigase-318 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureSocket | 0.331s |
2020-03-29 22:51:52 |
2020-03-29 22:51:52 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:51:52 | ------------------------------------ 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=632 thread=1] Connector state changed: null->connecting 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=632 thread=1] DNS entry stored in session object: missing:5222 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=632 thread=1] Preparing connection to [missing:5222] 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=632 thread=1] missing. Trying next. 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=632 thread=1] Connector state changed: connecting->disconnected 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-03-29 22:51:52 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: null->connecting 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] DNS entry stored in session object: localhost:5222 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Preparing connection to [localhost:5222] 2020-03-29 22:51:52 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: connecting->connected 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Whitespace ping period is setted to nullms 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@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-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4107] Start TLS 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4111] Proceeding TLS 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4111] Start handshake 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@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-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2JqdnhoYTA1NTgscj1EZGpSOVFvME1mS2w1ZjBkVHE4aw==</auth> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EZGpSOVFvME1mS2w1ZjBkVHE4a1BSZE5yNWYwSUhtSnlBeElCTEJkLHM9di9IdTdFSDVIMUFuWnc9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RGRqUjlRbzBNZktsNWYwZFRxOGtQUmROcjVmMElIbUp5QXhJQkxCZCxwPUhhV1Iyc1hYTHh0UVBnK3l1eXUxcGZUc0kvcnlqeFpndllEekd6bTdhZVE9</response> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1VWTAzUU1wUFh4ZnBBNG5BSjNuaURJNzJ4c3BtY28vc0ZVeU5SQWVoN2pNPQ==</success> 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost >> <iq xmlns="jabber:client" id="2nUrk5n1mWcv8LAydNPP7AA" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost << <iq xmlns="jabber:client" to="jaxmpp__bjvxha0558@localhost/2095755800-tigase-319" type="result" id="2nUrk5n1mWcv8LAydNPP7AA"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__bjvxha0558@localhost/2095755800-tigase-319</jid></bind></iq> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 >> <iq xmlns="jabber:client" id="DfuCsezg16AhV5l9EIRTaN3" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 << <iq xmlns="jabber:client" to="jaxmpp__bjvxha0558@localhost/2095755800-tigase-319" type="result" id="DfuCsezg16AhV5l9EIRTaN3"/> 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 >> <iq to="localhost" id="TqZtk7HQIGGDocHQ7r9Csez" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 << <enabled location="9585556aacac" max="60" xmlns="urn:xmpp:sm:3" resume="true" id="9bb18f0f-450c-4316-a4fb-6a09091ac6f1"/> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 >> <iq id="Wt6ZqS0kVYm1up1jW6w9qlK" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 << <iq xmlns="jabber:client" to="jaxmpp__bjvxha0558@localhost/2095755800-tigase-319" type="result" from="localhost" id="TqZtk7HQIGGDocHQ7r9Csez"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="router" category="component"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10703/4086d2cd" type="im" category="server"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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 type="pep" category="pubsub"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:filter:muted:0"/><feature var="tigase:push:priority: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-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 << <iq xmlns="jabber:client" to="jaxmpp__bjvxha0558@localhost/2095755800-tigase-319" type="result" id="Wt6ZqS0kVYm1up1jW6w9qlK"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Connector state changed: connected->disconnecting 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=1] Terminating XMPP Stream 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__bjvxha0558@localhost/2095755800-tigase-319 << <presence xmlns="jabber:client" to="jaxmpp__bjvxha0558@localhost" from="jaxmpp__bjvxha0558@localhost/2095755800-tigase-319"><c xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" node="http://tigase.org/jaxmpp" hash="sha-1"/></presence> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4111] Connector state changed: disconnecting->disconnected 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=633 thread=4111] Stream terminated 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterConnectionFailureWebSocket | 0.374s |
2020-03-29 22:51:53 |
2020-03-29 22:51:53 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-03-29 22:51:53 | ------------------------------------ 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@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-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX20yYnBwdzA1NTkscj1XdU9LSG56a2FaNkJ4NlFrbVY0UQ==</auth> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XdU9LSG56a2FaNkJ4NlFrbVY0UThMb0ZXQWFTcU5zN1RFelNUcDVGLHM9L0JITHBBdWQrQSsxc3c9PSxpPTQwOTY=</challenge> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V3VPS0huemthWjZCeDZRa21WNFE4TG9GV0FhU3FOczdURXpTVHA1RixwPTNjVGU4d3UyNTFTSTdsS2RjbVNOSjB4b3pZeHJyRUxsb3gzWUFuN3pwRjg9</response> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0vMU9jZ2RQQ3V3VEQ1MXRCeVJIVUNJc3grMThuSVpBK1UwRi9JNS9lZWFBPQ==</success> 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@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 xmlns="http://jabber.org/protocol/caps" ver="5J2MYGBPASPm0KgC9Q33WNw9Sxc=" node="https://tigase.net/tigase-xmpp-server" hash="SHA-1"/></features> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost >> <iq xmlns="jabber:client" id="kxb1slR6FN26seJAAtodDxo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost << <iq xmlns="jabber:client" to="jaxmpp__m2bppw0559@localhost/2095755800-tigase-320" type="result" id="kxb1slR6FN26seJAAtodDxo"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__m2bppw0559@localhost/2095755800-tigase-320</jid></bind></iq> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 >> <iq xmlns="jabber:client" id="sx9DwmZ6Cxwt9zs8AhGRMWZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 << <iq xmlns="jabber:client" to="jaxmpp__m2bppw0559@localhost/2095755800-tigase-320" type="result" id="sx9DwmZ6Cxwt9zs8AhGRMWZ"/> 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 >> <iq to="localhost" id="VuYITeueMPMYfWjPVayqX2z" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 >> <iq id="OmyADCEJDELZqS0kVYm1up1" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-03-29 22:51:53 | jaxmpp_ :: jaxmpp__m2bppw0559@localhost/2095755800-tigase-320 << <enabled location="9585556aacac" max="60" xmlns="urn:xmpp:sm:3" resume="true" id="422a7f47-5ade-461d-a7dc-2030a7fdabcb"/> 2020-03-29 22:51:53 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-03-29 22:51:53 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |