Test duration: 64.911s
| Passed Tests | ||
|---|---|---|
| tigase.tests.jaxmpp.TestHandlingOfConnectionIssues | ||
| testStateAfterAuthTimeoutBosh | 20.521s |
2020-05-26 01:04:42 |
2020-05-26 01:04:42 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:04:42 | ------------------------------------ 2020-05-26 01:04:42 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:04:42 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:04:42 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-05-26 01:04:42 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:02 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-05-26 01:05:02 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:02 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:02 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-05-26 01:05:02 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:02 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:02 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3NmZ3Y4YzA1NTUscj1KZ0JGSllqRVNENlVCRnNISzFSUw==</auth> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KZ0JGSllqRVNENlVCRnNISzFSU3RadmxRN0l6YTNhY0lsZE5QeGxOLHM9dVN2bGJJV1lLQzFId1E9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SmdCRkpZakVTRDZVQkZzSEsxUlN0WnZsUTdJemEzYWNJbGROUHhsTixwPStGTk11VzRBS01YbmNHRnVPYW5lOTNBcXZuWmRETDBtaERBVW1RcWd6TU09</response> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1oeTdKaE40NU5URG05RExVK0FoQkpIaHhDUkVKdFVWQ0IwallBNFV5elhBPQ==</success> 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost >> <iq xmlns="jabber:client" id="3n4P06vkP1viCBm5CCvfIsf" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost >> <iq xmlns="jabber:client" id="uDO6DFEiXgCxoXh1kGJCBEG" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost >> <iq xmlns="jabber:client" id="eMdUbO0hNOEDlT7s1p3gXjW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311" id="3n4P06vkP1viCBm5CCvfIsf" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311</jid></bind></iq> 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311 >> <iq to="localhost" id="8K5FHR02r2rk2lV4aFp1nY3" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311 >> <iq id="iPibBqS5fHJGtjRSbLQGJOI" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-312" id="uDO6DFEiXgCxoXh1kGJCBEG" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__sfgv8c0555@localhost/2095755800-tigase-312</jid></bind></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-311 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" id="eMdUbO0hNOEDlT7s1p3gXjW" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313</jid></bind></iq> 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <iq to="localhost" id="TNaJFFydNPO3vkEFGsdKFHR" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" id="iPibBqS5fHJGtjRSbLQGJOI" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <iq to="localhost" id="VGNfIxr7odPYWfQMR2fRbEk" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" from="localhost" id="8K5FHR02r2rk2lV4aFp1nY3" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <iq id="mwhdvdLKBznUfT6cLSQZiLT" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <iq id="TQdPR3kLT1cP3qQ3s0jW3tp" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <presence to="jaxmpp__sfgv8c0555@localhost" from="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" from="localhost" id="TNaJFFydNPO3vkEFGsdKFHR" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" from="localhost" id="VGNfIxr7odPYWfQMR2fRbEk" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313 << <iq to="jaxmpp__sfgv8c0555@localhost/2095755800-tigase-313" id="mwhdvdLKBznUfT6cLSQZiLT" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 |
| testStateAfterAuthTimeoutSocket | 20.299s |
2020-05-26 01:05:03 |
2020-05-26 01:05:03 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:05:03 | ------------------------------------ 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector state changed: null->connecting 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] DNS entry stored in session object: localhost:5222 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Preparing connection to [localhost:5222] 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Connector state changed: connecting->connected 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=1] Whitespace ping period is setted to nullms 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=4070] Start TLS 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=4072] Proceeding TLS 2020-05-26 01:05:03 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=4072] Start handshake 2020-05-26 01:05:03 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:03 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=4072] Connector state changed: connected->disconnected 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=629 thread=4072] Stream terminated 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: null->connecting 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] DNS entry stored in session object: localhost:5222 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Preparing connection to [localhost:5222] 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: connecting->connected 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Whitespace ping period is setted to nullms 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4070] Start TLS 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4077] Proceeding TLS 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4077] Start handshake 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2I2Njd6dDA1NTYscj1pY21HUTEyMktkS0ZaMVhBVXNTVQ==</auth> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pY21HUTEyMktkS0ZaMVhBVXNTVVlVMUUwMDdPS1BFQWJDSEs4a1VPLHM9ZEVOb0ZqZlRKWnhRNkE9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aWNtR1ExMjJLZEtGWjFYQVVzU1VZVTFFMDA3T0tQRUFiQ0hLOGtVTyxwPXo1NFR5NHZvNEREZGwzSnFJcTBRV3p6WXV6TnFISCtwSG9yWmxXTUlLTkk9</response> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OT1dWS1BDSG91OW1McXJaWUFwSGtmbHhKNVFMdGtrVDE0cWxEZ2tPcWowPQ==</success> 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <iq xmlns="jabber:client" id="oEvxp2bJHyxtgwpaq9CpbPW" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <iq xmlns="jabber:client" id="vKLhXeshUU7yhVjUQ3gTeQX" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-314" id="oEvxp2bJHyxtgwpaq9CpbPW" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__b667zt0556@localhost/2095755800-tigase-314</jid></bind></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost >> <iq xmlns="jabber:client" id="FMPl9AcLGJUcFzmKPJFFydN" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-315" id="vKLhXeshUU7yhVjUQ3gTeQX" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__b667zt0556@localhost/2095755800-tigase-315</jid></bind></iq> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-315 >> <iq xmlns="jabber:client" id="AZqw8zs5xxmKRS7GKLLKwnP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-315 >> <iq xmlns="jabber:client" id="zDkl2aDAl3zqS7o9KS1hMAv" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-315 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="FMPl9AcLGJUcFzmKPJFFydN" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__b667zt0556@localhost/2095755800-tigase-316</jid></bind></iq> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq xmlns="jabber:client" id="pRYBqXhNKVfOCBycHIBzBu0" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="AZqw8zs5xxmKRS7GKLLKwnP" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq to="localhost" id="a2tJKwpYj4wjRWU9nXfIxr7" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="zDkl2aDAl3zqS7o9KS1hMAv" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="pRYBqXhNKVfOCBycHIBzBu0" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <enabled resume="true" max="60" id="3ab773de-446f-4b0a-98e8-4537b40a09a8" location="9585556aacac" xmlns="urn:xmpp:sm:3"/> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq id="CMFXeDDJKwpYj4wjRWU9nXf" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" from="localhost" id="a2tJKwpYj4wjRWU9nXfIxr7" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq to="localhost" id="q2pmP1hIR7y6zu4rczvteul" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq to="localhost" id="pV2JGtjRSbLQGJOIJMJP7w4" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="CMFXeDDJKwpYj4wjRWU9nXf" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq id="0aJbGm5w8zs5xxmKRS7GKLL" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <iq id="3Krzu4rczvteulQ3yufJGo7" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" from="localhost" id="q2pmP1hIR7y6zu4rczvteul" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost/2095755800-tigase-316 << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" from="localhost" id="pV2JGtjRSbLQGJOIJMJP7w4" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Connector state changed: connected->disconnecting 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=1] Terminating XMPP Stream 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:23 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:23 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=630 thread=4077] Connector state changed: disconnecting->disconnected 2020-05-26 01:05:23 | jaxmpp_ :: jaxmpp__b667zt0556@localhost << <iq to="jaxmpp__b667zt0556@localhost/2095755800-tigase-316" id="0aJbGm5w8zs5xxmKRS7GKLL" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> |
| testStateAfterAuthTimeoutWebSocket | 20.347s |
2020-05-26 01:05:24 |
2020-05-26 01:05:24 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:05:24 | ------------------------------------ 2020-05-26 01:05:24 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-05-26 01:05:24 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-05-26 01:05:24 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-05-26 01:05:24 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:24 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-05-26 01:05:24 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.onStreamTerminate: Stream terminated 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2poeTNqazA1NTcscj1GQmVvTkVtdUZkcldZbHZWbW5iYg==</auth> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1GQmVvTkVtdUZkcldZbHZWbW5iYmJGRTlBMlVGQ1pzd1hkQ2xmak9pLHM9c1VMTVFoSzkwNnRWTGc9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RkJlb05FbXVGZHJXWWx2Vm1uYmJiRkU5QTJVRkNac3dYZENsZmpPaSxwPWs1WGlnV0VWVU9NaTI1d2VPcDVoWWxEYkMrYytPenpuaEpXZ2dJd1BzZlE9</response> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1TaEY0L2poVDh5S3VuOXNIT0NjRDVVOEdsZ21PR0I0ekZiK1UzbzFHREdBPQ==</success> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost >> <iq xmlns="jabber:client" id="9Z2LZgyt6zAynZcqbr5vezv" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost >> <iq xmlns="jabber:client" id="HiVsWfEFMW9xiCzdDBqXhNK" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost >> <iq xmlns="jabber:client" id="WbyEpbBm9HIqdMEBwdN3oOZ" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-317" id="9Z2LZgyt6zAynZcqbr5vezv" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__jhy3jk0557@localhost/2095755800-tigase-317</jid></bind></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-318" id="HiVsWfEFMW9xiCzdDBqXhNK" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__jhy3jk0557@localhost/2095755800-tigase-318</jid></bind></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319" id="WbyEpbBm9HIqdMEBwdN3oOZ" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319</jid></bind></iq> 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq xmlns="jabber:client" id="GeF7w4vaHQ4p3kGHt9Du5xj" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq xmlns="jabber:client" id="R6fQ17rdEpbBm9HIqdMEBwd" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq xmlns="jabber:client" id="wkTvkEFGsdKFHR02r2rk2lV" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319" id="GeF7w4vaHQ4p3kGHt9Du5xj" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319" id="R6fQ17rdEpbBm9HIqdMEBwd" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 << <iq to="jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319" id="wkTvkEFGsdKFHR02r2rk2lV" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq to="localhost" id="1jOgwpaq9CpbPWUbwpgU5p2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq id="X9i1p3gXjWS7AgPY7BFCgTW" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq to="localhost" id="RajYhDthMFHDqhXeshUU7yh" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq id="bq3IshIN2sbBqS5fHJGtjRS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq to="localhost" id="Rcl2pTZjQNX9sl5uYjY2n4j" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <iq id="4mNgCxoXh1kGJCBEGDveujH" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__jhy3jk0557@localhost/2095755800-tigase-319 << <enabled resume="true" max="60" id="05c7f663-7d9f-44a5-a30b-728b625dae62" location="9585556aacac" xmlns="urn:xmpp:sm:3"/> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected |
| testStateAfterConnectionFailureBosh | 0.729s |
2020-05-26 01:05:44 |
2020-05-26 01:05:44 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:05:44 | ------------------------------------ 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.connectors.bosh.BoshWorker.run: Connection error 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=0 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:44 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using BOSHConnector 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__7min5s0558@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:44 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__7min5s0558@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfXzdtaW41czA1NTgscj1rcWQ4dWk2SXp3UGxZMnJSTmphTw==</auth> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__7min5s0558@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rcWQ4dWk2SXp3UGxZMnJSTmphTzg3dHdxZFUxVWhWSmNsOWpGNUpQLHM9THVqUFFGUHJxTkVWZnc9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:44 | jaxmpp_ :: jaxmpp__7min5s0558@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3FkOHVpNkl6d1BsWTJyUk5qYU84N3R3cWRVMVVoVkpjbDlqRjVKUCxwPUJHb2dGazZxa09vU0JLWnJJa2F5K1hYdkI3QVZrU3NRMEhzMXM4N3BEY1U9</response> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1FOTNvTEh2S1VJSXVpYzBIZFdJOGJRd1NzcnpWUFpsODhDVGJkT01YaFBjPQ==</success> 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost >> <iq xmlns="jabber:client" id="noMW5vezvfEJR24vmOVavnd" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost << <iq to="jaxmpp__7min5s0558@localhost/2095755800-tigase-320" id="noMW5vezvfEJR24vmOVavnd" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__7min5s0558@localhost/2095755800-tigase-320</jid></bind></iq> 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost/2095755800-tigase-320 >> <iq to="localhost" id="fegcQ4p3kGHt9Du5xjMZn48" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost/2095755800-tigase-320 >> <iq id="xu0DgT8m1mT9LOEFul8EznY" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__7min5s0558@localhost/2095755800-tigase-320 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onTerminate: Stream terminated. responseCode=200 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.connector.AbstractBoshConnector.onError: responseCode=500 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] |
| testStateAfterConnectionFailureSocket | 0.353s |
2020-05-26 01:05:45 |
2020-05-26 01:05:45 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:05:45 | ------------------------------------ 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: null->connecting 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] DNS entry stored in session object: missing:5222 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Preparing connection to [missing:5222] 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] missing. Trying next. 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=634 thread=1] Connector state changed: connecting->disconnected 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using SocketConnector 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Connector state changed: null->connecting 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] DNS entry stored in session object: localhost:5222 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Preparing connection to [localhost:5222] 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Opening connection to localhost/127.0.0.1:5222 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Connector state changed: connecting->connected 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Whitespace ping period is setted to nullms 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__pglunl0559@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=4131] Start TLS 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__pglunl0559@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/> 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=4135] Proceeding TLS 2020-05-26 01:05:45 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=4135] Start handshake 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__pglunl0559@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:45 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__pglunl0559@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX3BnbHVubDA1NTkscj10SHQwcmxLNTdhWTJoZEhQWm1RQg==</auth> 2020-05-26 01:05:45 | jaxmpp_ :: jaxmpp__pglunl0559@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10SHQwcmxLNTdhWTJoZEhQWm1RQnBrNWRYZVdEcHhkZER0RmhnSm5ILHM9bmRZTDlKbFNGZnhhMUE9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dEh0MHJsSzU3YVkyaGRIUFptUUJwazVkWGVXRHB4ZGREdEZoZ0puSCxwPXA3cXM3Qnp4QU01V1B5T2hBVTJ3TGlyMEc2VE5SUDZWdDhXbThqcHlMQms9</response> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1qY0tSb2RDVk5xZDJMcSt3Y1BFRHcvZlN4dks4NXhhTjY0WXA4SEpaNHBBPQ==</success> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost >> <iq xmlns="jabber:client" id="GwYIIshIN2sbBqS5fHJGtjR" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost << <iq to="jaxmpp__pglunl0559@localhost/2095755800-tigase-321" id="GwYIIshIN2sbBqS5fHJGtjR" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__pglunl0559@localhost/2095755800-tigase-321</jid></bind></iq> 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 >> <iq xmlns="jabber:client" id="7tNdBzBu0nUbO0hNOEDlT7s" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 << <iq to="jaxmpp__pglunl0559@localhost/2095755800-tigase-321" id="7tNdBzBu0nUbO0hNOEDlT7s" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 >> <iq to="localhost" id="ey0tj4wjRWU9nXfIxr7odPY" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 << <enabled resume="true" max="60" id="1015df2a-49ad-4e76-b506-bfcd2f434026" location="9585556aacac" xmlns="urn:xmpp:sm:3"/> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 >> <iq id="RqAvlLJNOJPTWj1mINWYfON" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 << <iq to="jaxmpp__pglunl0559@localhost/2095755800-tigase-321" from="localhost" id="ey0tj4wjRWU9nXfIxr7odPY" xmlns="jabber:client" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" type="router" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><identity category="server" type="im" name="Tigase ver. 8.1.0-SNAPSHOT-b10741/15d7a283"/><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="jabber:iq:auth"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity 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: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="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 << <iq to="jaxmpp__pglunl0559@localhost/2095755800-tigase-321" id="RqAvlLJNOJPTWj1mINWYfON" xmlns="jabber:client" type="result"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Connector state changed: connected->disconnecting 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=1] Terminating XMPP Stream 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__pglunl0559@localhost/2095755800-tigase-321 << <presence to="jaxmpp__pglunl0559@localhost" from="jaxmpp__pglunl0559@localhost/2095755800-tigase-321" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence> 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=4135] Connector state changed: disconnecting->disconnected 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.SocketConnector.printLog: [scid=635 thread=4135] Stream terminated 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |
| testStateAfterConnectionFailureWebSocket | 0.301s |
2020-05-26 01:05:46 |
2020-05-26 01:05:46 | null / [TestClass name=class tigase.tests.jaxmpp.TestHandlingOfConnectionIssues] 2020-05-26 01:05:46 | ------------------------------------ 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=false 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->disconnected 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream, session] 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [stream] 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.login: state=disconnected cr=true 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.createConnector: Using WebSocketConnector 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Start connector. 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: null->connecting 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Preparing connection to localhost 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Opening connection to localhost/127.0.0.1:5290 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connecting->connected 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.websocket.WebSocketConnector.start: Whitespace ping period is setted to nullms 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.AuthModule.login: Authenticating with SASL Non-SASL 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.auth.SaslModule.login: Try login with SASL 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj1qYXhtcHBfX2syOG0zcjA1NjAscj1YMEdWVXczdzMxRlZTeXFta2YxcA==</auth> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YMEdWVXczdzMxRlZTeXFta2YxcFBQTXJvNzExU0JiZGVoaGpWYkJhLHM9eWdGMlhvUFlDSzFwUkE9PSxpPTQwOTY=</challenge> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WDBHVlV3M3czMUZWU3lxbWtmMXBQUE1ybzcxMVNCYmRlaGhqVmJCYSxwPTZwQzJFMm51bEFxUlhMa1RzUGxzWjdvd1lvZ2tmdFNpQlZ3QmRsY3VjMTg9</response> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1mR0h2ZU1FWUxlU2JJQmFvUVZ5L1YyYUU0OWhpM2ZUUlpXdFEzaForMnJNPQ==</success> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.StreamFeaturesModule.streamRestarted: Pipelining is disabled 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@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 ver="z4E8/RbDarYCAPa9avxwCC7J86E=" hash="SHA-1" xmlns="http://jabber.org/protocol/caps" node="https://tigase.net/tigase-xmpp-server"/></features> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost >> <iq xmlns="jabber:client" id="ruEINPO3vkEFGsdKFHR02r2" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost << <iq to="jaxmpp__k28m3r0560@localhost/2095755800-tigase-322" id="ruEINPO3vkEFGsdKFHR02r2" xmlns="jabber:client" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>jaxmpp__k28m3r0560@localhost/2095755800-tigase-322</jid></bind></iq> 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.Jaxmpp.onResourceBindSuccess: Connected. Resource binded. 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 >> <iq xmlns="jabber:client" id="GE6YeulQ3yufJGo7jPZcvnZ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 << <iq to="jaxmpp__k28m3r0560@localhost/2095755800-tigase-322" id="GE6YeulQ3yufJGo7jPZcvnZ" xmlns="jabber:client" type="result"/> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.enable: Enabling stream management 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 >> <iq to="localhost" id="YplmX4zxoMVcuhSVdT4aHyt" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 >> <iq id="LtvGO0hNOEDlT7s1p3gXjWS" type="get"><query xmlns="jabber:iq:roster"/></iq> 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence> 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: connected->disconnecting 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.terminateStream: Terminating XMPP Stream 2020-05-26 01:05:46 | jaxmpp_ :: jaxmpp__k28m3r0560@localhost/2095755800-tigase-322 << <enabled resume="true" max="60" id="3ea96942-dcda-44fd-b201-5c6812f32520" location="9585556aacac" xmlns="urn:xmpp:sm:3"/> 2020-05-26 01:05:46 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.connector.AbstractWebSocketConnector.setStage: Connector state changed: disconnecting->disconnected 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.xmpp.modules.streammng.StreamManagementModule.reset: Reset. 2020-05-26 01:05:46 | tigase.jaxmpp.core.client.AbstractSessionObject.clear: Clearing properties in scopes [session] 2020-05-26 01:05:49 | tigase.jaxmpp.j2se.connectors.socket.Worker.interrupt: Worker Interrupted |