Brute Force Prevention

Test duration: 14.890s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.186s
2019-12-12 20:26:16 |

2019-12-12 20:26:16 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-12 20:26:16 | ------------------------------------

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7a267da

2019-12-12 20:26:16 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@965995e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@d5a0caa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48589365}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5cd0a103}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:16 PST 2019}}}}

2019-12-12 20:26:16 | [Mutex] waiting for: [registration]

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@79da7cae

2019-12-12 20:26:16 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@965995e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@d5a0caa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48589365}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5cd0a103}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:16 PST 2019}}}}

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@24b81063

2019-12-12 20:26:16 | user :: null << <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>

2019-12-12 20:26:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28776c2a}

2019-12-12 20:26:16 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:16 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@71f6089e

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5b633502

2019-12-12 20:26:16 | user :: null << <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>

2019-12-12 20:26:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3fbc1d05}

2019-12-12 20:26:16 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:16 | user :: null >> <iq to="localhost" id="OSTPOFCqjFArl1pQaP3AsVa" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-12 20:26:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@74d4531f}

2019-12-12 20:26:16 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="OSTPOFCqjFArl1pQaP3AsVa"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-12-12 20:26:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2c3930e4}

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@6d4a6f05

2019-12-12 20:26:16 | user :: null >> <iq to="localhost" id="xUXh2mJMZ09u5xdNRVSexev" type="set"><query xmlns="jabber:iq:register"><username>user_g65xu20027</username><password>user_g65xu20027</password><email>5b4a38ae-a694-4c89-9549-cf8285760472@localhost</email></query></iq>

2019-12-12 20:26:16 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@551ca317}

2019-12-12 20:26:16 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="xUXh2mJMZ09u5xdNRVSexev"/>

2019-12-12 20:26:16 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2f438c8b}

2019-12-12 20:26:16 | [Mutex] received everything.

2019-12-12 20:26:16 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-12 20:26:16 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28776c2a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3fbc1d05]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@965995e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@d5a0caa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48589365}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5cd0a103}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:16 PST 2019}}}}

2019-12-12 20:26:16 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@28776c2a, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3fbc1d05]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@965995e}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@d5a0caa}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@48589365}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5cd0a103}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:16 PST 2019}}}}

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@70c8f853

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@151358be

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@2b1f2f5e

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@188bd962

2019-12-12 20:26:16 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@2fb6a040

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1PYzNUOEdMOG5VbUJGWUJWUUR6aw==</auth>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PYzNUOEdMOG5VbUJGWUJWUUR6a3V3dVRWMnBoZFlOUzVhV2xlbUV5LHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T2MzVDhHTDhuVW1CRllCVlFEemt1d3VUVjJwaGRZTlM1YVdsZW1FeSxwPTEzM1BSblBwTWZGeVNFNDZDbU15SU1oMTJPYTVGbEMxOUpJSkRvbDVPWTg9</response>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14ekZnNGdoWXFPNmFSRUxGbVpaYll5UXVqdjN5bnhxMGNvUHpNYWhSOStZPQ==</success>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="hl4VhwDjnzSaQaGklQvp8RGauF8=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <iq xmlns="jabber:client" id="SIlQ9lW9LR5cSfTgODABeBo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <iq id="SIlQ9lW9LR5cSfTgODABeBo" type="result" xmlns="jabber:client" to="user_g65xu20027@localhost/943755961-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_g65xu20027@localhost/943755961-tigase-19</jid></bind></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 >> <iq xmlns="jabber:client" id="aD4dNJPV38KziDyi39yndLT" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 << <iq id="aD4dNJPV38KziDyi39yndLT" type="result" xmlns="jabber:client" to="user_g65xu20027@localhost/943755961-tigase-19"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 >> <iq to="localhost" id="zWXal0rUX6jZ7Bt9k8lQJKG" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 << <enabled location="2938d31d0913" resume="true" xmlns="urn:xmpp:sm:3" max="60" id="1e3066ed-e968-4484-bbd9-73826e58d80d"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 >> <iq id="qJiP7zv2yBBGEjWjEr4fRR5" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 << <iq id="zWXal0rUX6jZ7Bt9k8lQJKG" from="localhost" type="result" xmlns="jabber:client" to="user_g65xu20027@localhost/943755961-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 << <iq id="qJiP7zv2yBBGEjWjEr4fRR5" type="result" xmlns="jabber:client" to="user_g65xu20027@localhost/943755961-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:16 | Disconnecting

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost/943755961-tigase-19 << <presence from="user_g65xu20027@localhost/943755961-tigase-19" xmlns="jabber:client" to="user_g65xu20027@localhost"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" hash="sha-1"/></presence>

2019-12-12 20:26:16 | [Mutex] notify: [disconnected]

2019-12-12 20:26:16 | [Mutex] received everything.

2019-12-12 20:26:16 | [Mutex] waiting for: [event]

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1IdjVFZ3pOcFg4WVZXaDJWN2J5NA==</auth>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1IdjVFZ3pOcFg4WVZXaDJWN2J5NGxkZFMyTEo3Q1RDckdhTUIxZVZJLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SHY1RWd6TnBYOFlWV2gyVjdieTRsZGRTMkxKN0NUQ3JHYU1CMWVWSSxwPXV1YnZmVjczL2Exa0lhbldyQTJKL3FQUC93dTROdXdJdnRWNlk0NmgwclE9</response>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:16 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:16 | [Mutex] received everything.

2019-12-12 20:26:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:16 | [Mutex] waiting for: [event]

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1pR0F1amJEakFsejY0NGt1M0JoNg==</auth>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pR0F1amJEakFsejY0NGt1M0JoNkQzS3YxU0xBRkNHUW4yTng3c0pLLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aUdBdWpiRGpBbHo2NDRrdTNCaDZEM0t2MVNMQUZDR1FuMk54N3NKSyxwPVQ1YjVXTUt2TjdML2hPMCtmblZqL0tnUEtvSnRiRkg0NjMxQnRzaU5IV2c9</response>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:16 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:16 | [Mutex] received everything.

2019-12-12 20:26:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:16 | [Mutex] waiting for: [event]

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj0xbHlCSTVGSmIwYnVkQlIxR3NVZA==</auth>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xbHlCSTVGSmIwYnVkQlIxR3NVZExudnZBenNMWEpHanVXdXJ4THYxLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MWx5Qkk1RkpiMGJ1ZEJSMUdzVWRMbnZ2QXpzTFhKR2p1V3VyeEx2MSxwPXczL2xreldFVk5GalFvcTFHdWUxQ3hPTnVpQWZGT0dSSUxxeHhxcE5ob2c9</response>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:16 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:16 | [Mutex] received everything.

2019-12-12 20:26:16 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:16 | [Mutex] waiting for: [event]

2019-12-12 20:26:16 | user :: user_g65xu20027@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>

2019-12-12 20:26:16 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj13TkxpWWVrSHNwaUxRR25rSDVFSQ==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13TkxpWWVrSHNwaUxRR25rSDVFSXpEM1JNRlZ2N2w1RTBsOHFIQnNHLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d05MaVlla0hzcGlMUUdua0g1RUl6RDNSTUZWdjdsNUUwbDhxSEJzRyxwPXc4Wnk1c0xPWFk3NGs3b2xZZm9uN3NWRXlHMVBoK2g4OHpNVWptdm5MdzQ9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj05V3o4QUZvUnMzOUhBaG91QW5CSQ==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05V3o4QUZvUnMzOUhBaG91QW5CSWJlR3pnN2EzTnJNU0t3cWlXSmFMLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OVd6OEFGb1JzMzlIQWhvdUFuQkliZUd6ZzdhM05yTVNLd3FpV0phTCxwPUNnTEU0MDJBejI0ZVg1Q0pySmRwRWh0T1o0SWZoWXpYeUpSU1lXcFpRazQ9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1tODhhSmpraTNDUkk1NkczdnVEWg==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tODhhSmpraTNDUkk1NkczdnVEWlZqTllXNDBlaVdUeVVXaTRCVU1jLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bTg4YUpqa2kzQ1JJNTZHM3Z1RFpWak5ZVzQwZWlXVHlVV2k0QlVNYyxwPTM3RVdhclFoeWwvbWtoejBDOHB5V09vTytaRmp0MzI2dzE0RE5OU2g0U0k9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1sQURPRjBYRXp1MzZHaElqanIzRg==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sQURPRjBYRXp1MzZHaElqanIzRjRRaTZsUllwN2s5MkI1SmZvUHVjLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bEFET0YwWEV6dTM2R2hJampyM0Y0UWk2bFJZcDdrOTJCNUpmb1B1YyxwPU1FeWtxU1ZrUTBIUEdNL1NjdExRdDFnSWIvYTdDTjhQREVjb3FCWGZEWEk9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj13WTlnNEhsekhlcjNoT2lPdkZTRQ==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13WTlnNEhsekhlcjNoT2lPdkZTRWE3a3hsc2FMRHUzdVppNm9aV1U4LHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d1k5ZzRIbHpIZXIzaE9pT3ZGU0VhN2t4bHNhTER1M3VaaTZvWldVOCxwPWpzKzRRUld0RnVRTUZVYmQ5SWFuMDI2MHJDaHZXUExZYVJDY0lQV0JpejA9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1xZXVvWDNIeWRVeTExQldENkVmVw==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xZXVvWDNIeWRVeTExQldENkVmV3ZrejI2UmdJOXZweXNMWTVubk44LHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWV1b1gzSHlkVXkxMUJXRDZFZld2a3oyNlJnSTl2cHlzTFk1bm5OOCxwPU8rem4yMWlqOXE4cUhtN0JwZzJGWXBpdjM5dFExQlVlUlZNZ2Fkd3N1WFk9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1TZkJUcVhFWWw2NkEzZm5wZTlTbg==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TZkJUcVhFWWw2NkEzZm5wZTlTbjJxVTFTUExzR2RiRXhOV0pFbDNJLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U2ZCVHFYRVlsNjZBM2ZucGU5U24ycVUxU1BMc0dkYkV4TldKRWwzSSxwPVhDTm1MNk9JeHMvVkJzUHUvaG5mbVp5cjVSTXFwa2lySXdLWHRvUTBSZ1U9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1KNkhTZ014VUR1WkJEeWVtYzAzMw==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1KNkhTZ014VUR1WkJEeWVtYzAzM0d4ZTVTTGxKVEVmUzMzYXdObkpoLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SjZIU2dNeFVEdVpCRHllbWMwMzNHeGU1U0xsSlRFZlMzM2F3Tm5KaCxwPVdkU1pyN2huV3pNUTJYdzdnUkxGb1FLYXk3ZGsvOVMxSWtIVHpsU1JwUTA9</response>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:17 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:17 | [Mutex] received everything.

2019-12-12 20:26:17 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:17 | [Mutex] waiting for: [event]

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:17 | user :: user_g65xu20027@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>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj10RnZGVFNucEE4UExTVE1xSG5DWQ==</auth>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj10RnZGVFNucEE4UExTVE1xSG5DWUltNFpISTJCbTZDdkNSUlpGTVZ2LHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:17 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dEZ2RlRTbnBBOFBMU1RNcUhuQ1lJbTRaSEkyQm02Q3ZDUlJaRk1WdixwPWx6L21nSk9CY3hXcVkvVEVXU0tnSWpEWEhvMjE3U2U4dnM2K2oxY1haaVE9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1TS0hGQTNaTVR1RmRiNW9EcndWUg==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TS0hGQTNaTVR1RmRiNW9EcndWUkQwM21ISUw0UFJkdk9ZZlBhSEZMLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9U0tIRkEzWk1UdUZkYjVvRHJ3VlJEMDNtSElMNFBSZHZPWWZQYUhGTCxwPXJKTHB4ZXdNMHF6bGNyWGp3cDFEN3JYWis1NGRCYXhrV1RXWUpnb2pOdWc9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1FM29iZjFaSnpaWklTcWZNVnVqdA==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FM29iZjFaSnpaWklTcWZNVnVqdFRaQkE0OVdVVXlnaFJKM0dzdWMyLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RTNvYmYxWkp6WlpJU3FmTVZ1anRUWkJBNDlXVVV5Z2hSSjNHc3VjMixwPTFNZlhZa0FZVWdvRVhaQzUvUDZwdlh6clYwdk5FQ1lvaTlwNUpORVhiWEE9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1sUUZxZHNmU3haR0N5cTlVS1FYUQ==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sUUZxZHNmU3haR0N5cTlVS1FYUWxZN3dXSUlUMHd6R2UyWTROOXFZLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bFFGcWRzZlN4WkdDeXE5VUtRWFFsWTd3V0lJVDB3ekdlMlk0TjlxWSxwPUwxZlowazZ2ampjSnB3djJFSGI3N0pnSFREWTFFb0NBTGJTQUpxRExoOHc9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj11RnRBcnpqWXNmMWZlZXEydTZSMg==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11RnRBcnpqWXNmMWZlZXEydTZSMjZoUDI0ZmtJc09JdTUzY0pvdFpHLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dUZ0QXJ6allzZjFmZWVxMnU2UjI2aFAyNGZrSXNPSXU1M2NKb3RaRyxwPUV2MkluU1l3KzViN2lEaGRsNDZnQlN5ZGRqbTBoYlVKVWdqdXFoclFXMFk9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj0wTDNZZkU3bW82Nkc3OUJQTWFKdA==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wTDNZZkU3bW82Nkc3OUJQTWFKdER6bU11MzVVdTEwUW1taEJNYW5MLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MEwzWWZFN21vNjZHNzlCUE1hSnREem1NdTM1VXUxMFFtbWhCTWFuTCxwPWRlaXQxSXU4VzdrU29aK3hGcjh0WEtkdEdvYzgrWWs4dDdJaGZ1RUFNR3c9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] notify: [event, disconnected]

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1XZ1VJSUZHVWo4VDBYQU1aaHVGTA==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XZ1VJSUZHVWo4VDBYQU1aaHVGTFg4T29jYXpUdTBxT1hRZnE0ZjZyLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V2dVSUlGR1VqOFQwWEFNWmh1RkxYOE9vY2F6VHUwcU9YUWZxNGY2cixwPVIvbkI4cVZ2TGpGSkQxNGJNKzl2elAyREtaWUNmWVdWM3BJTm9zMEk3TGs9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1OQ0JWWDJ2OTgxVjl5QW44RHFSRA==</auth>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OQ0JWWDJ2OTgxVjl5QW44RHFSRHhuV0dKV1pSdDZNdnd1Y1JDRHZOLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TkNCVlgydjk4MVY5eUFuOERxUkR4bldHSldaUnQ2TXZ3dWNSQ0R2TixwPVZHbXl3ZEh4bVRWU3IzTDBja0JDQXNOWG8rV2JBcG1rYllERHNwZ2oycWs9</response>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:18 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:18 | [Mutex] received everything.

2019-12-12 20:26:18 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:18 | [Mutex] waiting for: [event]

2019-12-12 20:26:18 | user :: user_g65xu20027@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>

2019-12-12 20:26:18 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:19 | user :: user_g65xu20027@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>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj02cUtqNXB4OVNOZWhRUHg5bUl2VA==</auth>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02cUtqNXB4OVNOZWhRUHg5bUl2VE5GSVZsaEdtQ0dVQUtqSHFjbUdqLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NnFLajVweDlTTmVoUVB4OW1JdlRORklWbGhHbUNHVUFLakhxY21HaixwPXZrMS9kYTk2bTg1cko0ZVB4QlN2VTJXVjdscnFXNFR1SUpZVnJYaGhzQjA9</response>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:19 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:19 | [Mutex] received everything.

2019-12-12 20:26:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:19 | [Mutex] waiting for: [event]

2019-12-12 20:26:19 | user :: user_g65xu20027@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>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:19 | user :: user_g65xu20027@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>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1iUHJsUG5NTGxKdzJSTGNZRWVPQw==</auth>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iUHJsUG5NTGxKdzJSTGNZRWVPQ0VIaTVXVEFXVjBFWm9Wb0FzT2lMLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YlBybFBuTUxsSncyUkxjWUVlT0NFSGk1V1RBV1YwRVpvVm9Bc09pTCxwPVhmMlRTekpSSU5wSDZVWXZwbU1hMUIvd2dlL2ZDWXpNNXFWbVNXcEQ1b009</response>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:19 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:19 | [Mutex] received everything.

2019-12-12 20:26:19 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:19 | user :: user_g65xu20027@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>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:19 | user :: user_g65xu20027@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>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2c2NXh1MjAwMjcscj1JcWlsMjJ5MzIwVHk0cHJIQkc0Mw==</auth>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1JcWlsMjJ5MzIwVHk0cHJIQkc0M2czTkJpeWhYSVpjZGltN3ZCb2dZLHM9ZXZxWFVLd0dHVkxxMFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SXFpbDIyeTMyMFR5NHBySEJHNDNnM05CaXloWElaY2RpbTd2Qm9nWSxwPVdodUhPRytTSE4vWnlCTzdNYUE1RlpkRkNhL3hxU1I4My9nbmdmUm5CYXc9</response>

2019-12-12 20:26:19 | user :: user_g65xu20027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_g65xu20027@localhost is not authorized to act as user_g65xu20027@localhost</text></failure>

2019-12-12 20:26:21 | [Mutex] waiting for: [user]

2019-12-12 20:26:21 | [Mutex] received everything.

2019-12-12 20:26:21 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.370s
2019-12-12 20:26:21 |

2019-12-12 20:26:21 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-12 20:26:21 | ------------------------------------

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1c7ac620

2019-12-12 20:26:21 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12bd2bdf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1682ad50}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@538021e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1981a672}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:21 PST 2019}}}}

2019-12-12 20:26:21 | [Mutex] waiting for: [registration]

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@6299954e

2019-12-12 20:26:21 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12bd2bdf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1682ad50}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@538021e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1981a672}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:21 PST 2019}}}}

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@61724c60

2019-12-12 20:26:21 | user :: null << <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>

2019-12-12 20:26:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33afdeab}

2019-12-12 20:26:21 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:21 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@27094c9a

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@9148ed0

2019-12-12 20:26:21 | user :: null << <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>

2019-12-12 20:26:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a76c2de}

2019-12-12 20:26:21 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:21 | user :: null >> <iq to="localhost" id="kG37weVT2l9DDi4DFOUPYnM" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-12 20:26:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@878be2fa}

2019-12-12 20:26:21 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="kG37weVT2l9DDi4DFOUPYnM"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-12-12 20:26:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@37e101bd}

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5a61f647

2019-12-12 20:26:21 | user :: null >> <iq to="localhost" id="w12xtq8hSboV2bJBzp14CjM" type="set"><query xmlns="jabber:iq:register"><username>user_7rt7ch0028</username><password>user_7rt7ch0028</password><email>50528b42-8687-4700-8a64-34bebd5bfa54@localhost</email></query></iq>

2019-12-12 20:26:21 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@dceaf822}

2019-12-12 20:26:21 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="w12xtq8hSboV2bJBzp14CjM"/>

2019-12-12 20:26:21 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@772e81d5}

2019-12-12 20:26:21 | [Mutex] received everything.

2019-12-12 20:26:21 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-12 20:26:21 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33afdeab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a76c2de]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12bd2bdf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1682ad50}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@538021e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1981a672}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:21 PST 2019}}}}

2019-12-12 20:26:21 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@33afdeab, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a76c2de]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@12bd2bdf}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@1682ad50}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@538021e4}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1981a672}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:21 PST 2019}}}}

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3b02cddc

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@4d1dfe8

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@51d7d2fb

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5274d13d

2019-12-12 20:26:21 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7fb58a82

2019-12-12 20:26:21 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj1HdHgwaTRhNWFHS0tOOWIwRGREWQ==</auth>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HdHgwaTRhNWFHS0tOOWIwRGREWWFNejhFQzFhbHN3Z1FQZ0lVbXd1LHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R3R4MGk0YTVhR0tLTjliMERkRFlhTXo4RUMxYWxzd2dRUGdJVW13dSxwPWRteElKamhGSVVvTDNscUxoRzgxcUFUQTdPQWZqNldXa083YytoeGpRT3c9</response>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10VmU0eEorWWpSYW1URVNhK3lZc1M3dGdoZGxlc291ZldmOXhKby80bjRvPQ==</success>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="hl4VhwDjnzSaQaGklQvp8RGauF8=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost >> <iq xmlns="jabber:client" id="KVIFx6Gr27weVT2l9DDi4DF" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost << <iq id="KVIFx6Gr27weVT2l9DDi4DF" type="result" xmlns="jabber:client" to="user_7rt7ch0028@localhost/943755961-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7rt7ch0028@localhost/943755961-tigase-20</jid></bind></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 >> <iq xmlns="jabber:client" id="PERQJKGPHEzBxrUi5zCw3qh" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 << <iq id="PERQJKGPHEzBxrUi5zCw3qh" type="result" xmlns="jabber:client" to="user_7rt7ch0028@localhost/943755961-tigase-20"/>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 >> <iq to="localhost" id="s32n7g0vpiSLQ7gFw9FtjTZ" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 >> <iq id="aNexr1p5nM29sXcADjS1vl3" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 << <enabled location="2938d31d0913" resume="true" xmlns="urn:xmpp:sm:3" max="60" id="4c28cf10-af8d-4359-bd24-2443b9ab7c4a"/>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 << <iq id="s32n7g0vpiSLQ7gFw9FtjTZ" from="localhost" type="result" xmlns="jabber:client" to="user_7rt7ch0028@localhost/943755961-tigase-20"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-12 20:26:21 | user :: user_7rt7ch0028@localhost/943755961-tigase-20 << <iq id="aNexr1p5nM29sXcADjS1vl3" type="result" xmlns="jabber:client" to="user_7rt7ch0028@localhost/943755961-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:21 | Disconnecting

2019-12-12 20:26:21 | [Mutex] notify: [disconnected]

2019-12-12 20:26:21 | [Mutex] received everything.

2019-12-12 20:26:22 | [Mutex] waiting for: [event]

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj14b1E1NHlwUmt1TnJCYTNQSDY5WA==</auth>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj14b1E1NHlwUmt1TnJCYTNQSDY5WExTV296RDlxUmRsZ2RRQ0NuTE1oLHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eG9RNTR5cFJrdU5yQmEzUEg2OVhMU1dvekQ5cVJkbGdkUUNDbkxNaCxwPXd5RnNNTlNkaHgycUtxdm8rd2FvOVlScW4ySS81R3hsOWpkbWJ1SnhHeWM9</response>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:22 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:22 | [Mutex] received everything.

2019-12-12 20:26:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:22 | [Mutex] waiting for: [event]

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj1tV2xZdEJMQnJpcndreWxiblVKQg==</auth>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tV2xZdEJMQnJpcndreWxiblVKQkFIaXRLREpZajBKR1pFbE1WMnpMLHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVdsWXRCTEJyaXJ3a3lsYm5VSkJBSGl0S0RKWWowSkdaRWxNVjJ6TCxwPXNQb05EQ3ZyZXFNdThYbTZlWEhaWjNYZEhkVVgxL1BaMXJrYUpYdWlkaW89</response>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:22 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:22 | [Mutex] received everything.

2019-12-12 20:26:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:22 | [Mutex] waiting for: [event]

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj02b0k4YlBHYTFaRUEybUxmaWRTNg==</auth>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02b0k4YlBHYTFaRUEybUxmaWRTNkRNS29NeWJVcGx5Skt2dkhEellCLHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Nm9JOGJQR2ExWkVBMm1MZmlkUzZETUtvTXliVXBseUpLdnZIRHpZQixwPVhzaWkvUTdESktaUldtdE95OUU0L3JVL0FnZWNrZzlhZFkyNk5lOVdQM0k9</response>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:22 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:22 | [Mutex] received everything.

2019-12-12 20:26:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:22 | [Mutex] notify: [event, disconnected]

2019-12-12 20:26:22 | [Mutex] waiting for: [event]

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj1pR2J2aWFBZXFhb3NDRzlGbHF3Wg==</auth>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pR2J2aWFBZXFhb3NDRzlGbHF3WlExS0JEQVU1V0FSWWdSNDN2NTIxLHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aUdidmlhQWVxYW9zQ0c5Rmxxd1pRMUtCREFVNVdBUllnUjQzdjUyMSxwPTVzRkRndWtDU21mNzlrWEk5MjFIa1F2aFNuN3BmcytaLzVrQmxuMUtsZGc9</response>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:22 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:22 | [Mutex] received everything.

2019-12-12 20:26:22 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@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>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdydDdjaDAwMjgscj1ldENtb3RjMDlwVDZZV2xDZHFLaA==</auth>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ldENtb3RjMDlwVDZZV2xDZHFLaG9zUmxjdWZzQXp1RW1laTVGZ3Y3LHM9U3psMlZSK3V3ZWlTdXc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZXRDbW90YzA5cFQ2WVdsQ2RxS2hvc1JsY3Vmc0F6dUVtZWk1Rmd2NyxwPTBhemFyWThINDhuZW9YVzdlbzczblRnQWdnMURBQUNjek95ZXdrMkJaWlE9</response>

2019-12-12 20:26:22 | user :: user_7rt7ch0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:24 | [Mutex] waiting for: [user]

2019-12-12 20:26:24 | [Mutex] received everything.

2019-12-12 20:26:24 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.103s
2019-12-12 20:26:24 |

2019-12-12 20:26:24 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-12 20:26:24 | ------------------------------------

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@1ab66a5c

2019-12-12 20:26:24 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1471977a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@104e012c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@554c9d41}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c01e93e}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:24 PST 2019}}}}

2019-12-12 20:26:24 | [Mutex] waiting for: [registration]

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@64d36b83

2019-12-12 20:26:24 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1471977a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@104e012c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@554c9d41}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c01e93e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:24 PST 2019}}}}

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@4744154

2019-12-12 20:26:24 | user :: null << <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>

2019-12-12 20:26:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3563620e}

2019-12-12 20:26:24 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:24 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@46583585

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3928c1be

2019-12-12 20:26:24 | user :: null << <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>

2019-12-12 20:26:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f70492e}

2019-12-12 20:26:24 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:24 | user :: null >> <iq to="localhost" id="EGNHAhVZlX7g05kHGyzbCvt" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-12 20:26:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@fd477286}

2019-12-12 20:26:24 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="EGNHAhVZlX7g05kHGyzbCvt"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-12-12 20:26:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@312d3bdc}

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@365ec461

2019-12-12 20:26:24 | user :: null >> <iq to="localhost" id="NHO4dAdICHr8xxpbog1rm01" type="set"><query xmlns="jabber:iq:register"><username>user_7ocsh10029</username><password>user_7ocsh10029</password><email>bad19c06-281e-4cb3-b047-85421b0c34d2@localhost</email></query></iq>

2019-12-12 20:26:24 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4a13963c}

2019-12-12 20:26:24 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="NHO4dAdICHr8xxpbog1rm01"/>

2019-12-12 20:26:24 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4984d625}

2019-12-12 20:26:24 | [Mutex] received everything.

2019-12-12 20:26:24 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-12 20:26:24 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3563620e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f70492e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1471977a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@104e012c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@554c9d41}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c01e93e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:24 PST 2019}}}}

2019-12-12 20:26:24 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3563620e, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@1f70492e]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@1471977a}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@104e012c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@554c9d41}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7c01e93e}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:24 PST 2019}}}}

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@54a0cf02

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@c8bfd91

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@4c364dad

2019-12-12 20:26:24 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@23ec9ff0

2019-12-12 20:26:25 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@71e69c50

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdvY3NoMTAwMjkscj1zMHpLOUN0R2dLdkkxTlBMWFpoaw==</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zMHpLOUN0R2dLdkkxTlBMWFpoa0loUWFQQlhtR2xZQXp3YXljd1ZvLHM9N21uYUdlMUljMWxGdFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9czB6SzlDdEdnS3ZJMU5QTFhaaGtJaFFhUEJYbUdsWUF6d2F5Y3dWbyxwPWdURlJkaW4yV2t4RzdpQ1B6YjljeHZubUtYUktFdHRqYi9vbjAwTGEvSTg9</response>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OSlJ6cjk0QjJOODNwelpjdEZwZHRvRkpZVVEwQlJqOEErL3dWRmtSUDV3PQ==</success>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="hl4VhwDjnzSaQaGklQvp8RGauF8=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <iq xmlns="jabber:client" id="gTmIUTWV8snNQXn5x6GR7II" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <iq id="gTmIUTWV8snNQXn5x6GR7II" type="result" xmlns="jabber:client" to="user_7ocsh10029@localhost/943755961-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7ocsh10029@localhost/943755961-tigase-21</jid></bind></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 >> <iq xmlns="jabber:client" id="rYzztjEM3vugxods3iHLFHF" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 << <iq id="rYzztjEM3vugxods3iHLFHF" type="result" xmlns="jabber:client" to="user_7ocsh10029@localhost/943755961-tigase-21"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 >> <iq to="localhost" id="zcdGn4zat8n7n7vdsoRSNSW" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 << <enabled location="2938d31d0913" resume="true" xmlns="urn:xmpp:sm:3" max="60" id="ea279a5b-73ff-489c-a5fa-1b3b27f954a2"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 >> <iq id="BKPWjEr4fRR5r5cSPOFCqjF" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 << <iq id="zcdGn4zat8n7n7vdsoRSNSW" from="localhost" type="result" xmlns="jabber:client" to="user_7ocsh10029@localhost/943755961-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 << <iq id="BKPWjEr4fRR5r5cSPOFCqjF" type="result" xmlns="jabber:client" to="user_7ocsh10029@localhost/943755961-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:25 | Disconnecting

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost/943755961-tigase-21 << <presence from="user_7ocsh10029@localhost/943755961-tigase-21" xmlns="jabber:client" to="user_7ocsh10029@localhost"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" hash="sha-1"/></presence>

2019-12-12 20:26:25 | [Mutex] notify: [disconnected]

2019-12-12 20:26:25 | [Mutex] received everything.

2019-12-12 20:26:25 | [Mutex] waiting for: [event]

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdvY3NoMTAwMjkscj1peHJQMVJIZXlpRmp4OHlNUFZCcg==</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1peHJQMVJIZXlpRmp4OHlNUFZCcjJUaWpLQWhSOWcxMGVlbmpzNGJjLHM9N21uYUdlMUljMWxGdFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aXhyUDFSSGV5aUZqeDh5TVBWQnIyVGlqS0FoUjlnMTBlZW5qczRiYyxwPXVTWVMyWUZSeFdJWEZvNXoweEg2MEQybmV6eG5iKys5SDdQNXlOWkV3dGc9</response>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:25 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:25 | [Mutex] received everything.

2019-12-12 20:26:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:25 | [Mutex] waiting for: [event]

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfN29jc2gxMDAyOQAgLSAtIC0gLSAt</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:25 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:25 | [Mutex] received everything.

2019-12-12 20:26:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:25 | [Mutex] notify: [event, disconnected]

2019-12-12 20:26:25 | [Mutex] waiting for: [event]

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzdvY3NoMTAwMjkscj12R0I2TDN2RGlYZnhtUWpkYlhldw==</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12R0I2TDN2RGlYZnhtUWpkYlhld0sxSjdEQXJEY0pTMjVKUjFTU3llLHM9VFFaL0RVWmQxeVR5aHc9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkdCNkwzdkRpWGZ4bVFqZGJYZXdLMUo3REFyRGNKUzI1SlIxU1N5ZSxwPUwzczBQUXkwdkJsK2ttWDZMQmNvYjVDZnEyZz0=</response>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:25 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:25 | [Mutex] received everything.

2019-12-12 20:26:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:25 | [Mutex] waiting for: [event]

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfN29jc2gxMDAyOQAgLSAtIC0gLSAt</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:25 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:25 | [Mutex] received everything.

2019-12-12 20:26:25 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:25 | user :: user_7ocsh10029@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>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdvY3NoMTAwMjkscj1qazJkczNBVzY3c0dJelU0bjBDdQ==</auth>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qazJkczNBVzY3c0dJelU0bjBDdTFmcFdvTWtvajBzRjJnUllLNkJILHM9N21uYUdlMUljMWxGdFE9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amsyZHMzQVc2N3NHSXpVNG4wQ3UxZnBXb01rb2owc0YyZ1JZSzZCSCxwPWcrSjRDa04xWHFnRFNiaU9ERmFDWXRDMHhGWVZwWk5Bb3ZaaDVjd0RVSlE9</response>

2019-12-12 20:26:25 | user :: user_7ocsh10029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:27 | [Mutex] waiting for: [user]

2019-12-12 20:26:27 | [Mutex] received everything.

2019-12-12 20:26:27 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 2.972s
2019-12-12 20:26:27 |

2019-12-12 20:26:27 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-12-12 20:26:27 | ------------------------------------

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@3d5024c8

2019-12-12 20:26:27 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3397cd12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@37a84fb8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@72aac729}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4ee0dbd0}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:27 PST 2019}}}}

2019-12-12 20:26:27 | [Mutex] waiting for: [registration]

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@43927043

2019-12-12 20:26:27 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3397cd12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=connected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@37a84fb8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@72aac729}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4ee0dbd0}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=1}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:27 PST 2019}}}}

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@36323206

2019-12-12 20:26:27 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:27 | user :: null << <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>

2019-12-12 20:26:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12853866}

2019-12-12 20:26:27 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5af34fbd

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@ab32cc8

2019-12-12 20:26:27 | user :: null << <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>

2019-12-12 20:26:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2d369d9a}

2019-12-12 20:26:27 | StreamFeaturesReceivedEvent[<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>]

2019-12-12 20:26:27 | user :: null >> <iq to="localhost" id="MZsUiFu1kQ9lW9LR5cSfTgO" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-12-12 20:26:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@82485296}

2019-12-12 20:26:27 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="MZsUiFu1kQ9lW9LR5cSfTgO"><query xmlns="jabber:iq:register"><instructions>Choose a user name and password for use with this service.Please also provide your e-mail address to which we will send confirmation link (MUST BE VALID!)</instructions><username/><password/><email/></query></iq>

2019-12-12 20:26:27 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@16cbc652}

2019-12-12 20:26:27 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5605ed91

2019-12-12 20:26:27 | user :: null >> <iq to="localhost" id="FWhIxr1p5nM29sXcADjS1vl" type="set"><query xmlns="jabber:iq:register"><username>user_petmyb0030</username><password>user_petmyb0030</password><email>7b588da7-d4bb-439a-882e-440221f3c7f6@localhost</email></query></iq>

2019-12-12 20:26:27 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28c8f2c7}

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:28 | [Mutex] isItemNotified: registrationSuccess :: true

2019-12-12 20:26:28 | user :: null << <iq from="localhost" type="result" xmlns="jabber:client" id="FWhIxr1p5nM29sXcADjS1vl"/>

2019-12-12 20:26:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@45c35ef5}

2019-12-12 20:26:28 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12853866, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2d369d9a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3397cd12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnecting}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@37a84fb8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@72aac729}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4ee0dbd0}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:28 PST 2019}}}}

2019-12-12 20:26:28 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@2f79b9ea}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@12853866, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2d369d9a]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@3397cd12}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@6e44b3d1}, BOSH#SEE_OTHER_HOST_KEY=Entry{scope=user, value=false}, CONNECTOR#STAGE_KEY=Entry{scope=stream, value=disconnected}, RosterModule#ROSTER_STORE=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.modules.roster.DefaultRosterStore@37a84fb8}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@72aac729}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4ee0dbd0}, StreamFeaturesModule#PIPELINING_ACTIVE=Entry{scope=session, value=false}, DEFAULT_XMPP_STREAM_KEY=Entry{scope=session, value=DefaultXMPPStream}, domainName=Entry{scope=user, value=localhost}, StreamFeaturesModule#EMBEDDED_STREAMS_COUNTER=Entry{scope=session, value=2}, LOG_PREFIX=Entry{scope=user, value=user}, socket#ServerHost=Entry{scope=user, value=localhost}, IN_BAND_REGISTRATION_MODE_KEY=Entry{scope=session, value=true}, CONNECTOR#CONNECTOR_STAGE_TIMESTAMP_KEY=Entry{scope=stream, value=Thu Dec 12 20:26:28 PST 2019}}}}

2019-12-12 20:26:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5c00c19a

2019-12-12 20:26:28 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@14b1651e

2019-12-12 20:26:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6da16b7c

2019-12-12 20:26:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@32caa4cb

2019-12-12 20:26:28 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@689cbf19

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BldG15YjAwMzAscj1Gb0U1RmVNekFhVFY5cno5dGpxeg==</auth>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Gb0U1RmVNekFhVFY5cno5dGpxelRzQTYwY3UyQ1VocHY0MXdiMDBLLHM9ckRRY2JzVDkybnlWc2c9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Rm9FNUZlTXpBYVRWOXJ6OXRqcXpUc0E2MGN1MkNVaHB2NDF3YjAwSyxwPVYrd0FBK2NUbnc2RFVkQ09vRVVsdHV3R3pwZTBtRHhydG9hekZjVHNEeTQ9</response>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj00aEV0UFI5UVlFRGRzQXo5T1Z6TzVBYWtGMTYxZ2dwUEVHRU9haEREeFd3PQ==</success>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="hl4VhwDjnzSaQaGklQvp8RGauF8=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <iq xmlns="jabber:client" id="7fakNMFHxr9v2ybw5s6Fn0h" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <iq id="7fakNMFHxr9v2ybw5s6Fn0h" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_petmyb0030@localhost/943755961-tigase-22</jid></bind></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 >> <iq xmlns="jabber:client" id="8RY3iHLFHFx6Gr27weVT2l9" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 << <iq id="8RY3iHLFHFx6Gr27weVT2l9" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-22"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 >> <iq to="localhost" id="ESZ5mP1bJJFmct6fMKXXaBF" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 << <enabled location="2938d31d0913" resume="true" xmlns="urn:xmpp:sm:3" max="60" id="83c67a54-9922-4ecb-a1b6-dee8d1773c3d"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 >> <iq id="pU3kVjXhAENZscp8HqZarfD" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 << <iq id="ESZ5mP1bJJFmct6fMKXXaBF" from="localhost" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-22"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 << <iq id="pU3kVjXhAENZscp8HqZarfD" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:28 | Disconnecting

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-22 << <presence from="user_petmyb0030@localhost/943755961-tigase-22" xmlns="jabber:client" to="user_petmyb0030@localhost"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" hash="sha-1"/></presence>

2019-12-12 20:26:28 | [Mutex] notify: [disconnected]

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:28 | [Mutex] waiting for: [event]

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BldG15YjAwMzAscj1LVkFoWTJpMUNrUWtZR2VMUmZBSg==</auth>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1LVkFoWTJpMUNrUWtZR2VMUmZBSlBqc0x3YnBoR1pWUlFoaTJ3aWFnLHM9ckRRY2JzVDkybnlWc2c9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9S1ZBaFkyaTFDa1FrWUdlTFJmQUpQanNMd2JwaEdaVlJRaGkyd2lhZyxwPWJ4RDBWWlBUaDVOUmdVOEMyWHRwMG5VeUNRWXY0bWxRUkFIb3VVZVZVcnc9</response>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:28 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:28 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:28 | [Mutex] waiting for: [event]

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BldG15YjAwMzAscj0xbVRXZnVMZEVWSVBrODhrUkdDYQ==</auth>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xbVRXZnVMZEVWSVBrODhrUkdDYW1xaGU0QjF1dTlseUVRT2JVTVFILHM9ckRRY2JzVDkybnlWc2c9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MW1UV2Z1TGRFVklQazg4a1JHQ2FtcWhlNEIxdXU5bHlFUU9iVU1RSCxwPTI1N2ZYbklYRWR1UFlmZDFDN1lrWE9oczNHMExwRE9JN2xxOXUvNnY2bkE9</response>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:28 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:28 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:28 | [Mutex] waiting for: [event]

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BldG15YjAwMzAscj02dktLbk5SOVNnTzdoZEVLaXhKdA==</auth>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02dktLbk5SOVNnTzdoZEVLaXhKdGdjOVdKM3pybXhsczB3dWJTVFB1LHM9ckRRY2JzVDkybnlWc2c9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NnZLS25OUjlTZ083aGRFS2l4SnRnYzlXSjN6cm14bHMwd3ViU1RQdSxwPWluNGxxKzVFMlVwNGNiZHE5VGtvRURiTWpEdVJ0MXExV0p4cURFZm1RY1k9</response>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-12-12 20:26:28 | [Mutex] notify: [event, authFailed]

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:28 | [Mutex] isItemNotified: authFailed :: true

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@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>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3BldG15YjAwMzAscj11ODRNZFVOajQ0ZDRyMk5GTWpnTA==</auth>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11ODRNZFVOajQ0ZDRyMk5GTWpnTFFYYk51cHQ5b1VNT1ZIeHBaNEFoLHM9ckRRY2JzVDkybnlWc2c9PSxpPTQwOTY=</challenge>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dTg0TWRVTmo0NGQ0cjJORk1qZ0xRWGJOdXB0OW9VTU9WSHhwWjRBaCxwPWJCSWRmRHNuVXNNYWMyV2xMK2RlNHNFcVZsNDdxWExFcDNWdGMxclk3TVk9</response>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1tdWFscEpBdTdjcGxBcnk2QmJ2K20vR1BTNjBHYmQxNm91elI4UUxQMTR3PQ==</success>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><csi xmlns="urn:xmpp:csi:0"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"/><session xmlns="urn:ietf:params:xml:ns:xmpp-session"><optional/></session><c node="https://tigase.net/tigase-xmpp-server" ver="hl4VhwDjnzSaQaGklQvp8RGauF8=" xmlns="http://jabber.org/protocol/caps" hash="SHA-1"/></features>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost >> <iq xmlns="jabber:client" id="L9KFmct6fMKXXaBFFHqk9HS" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost << <iq id="L9KFmct6fMKXXaBFFHqk9HS" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_petmyb0030@localhost/943755961-tigase-23</jid></bind></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 >> <iq xmlns="jabber:client" id="2i9KMzslIzkLTVdHBeWX4bE" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 << <iq id="2i9KMzslIzkLTVdHBeWX4bE" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-23"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 >> <iq to="localhost" id="7lgwbydNJPV38KziDyi39yn" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 << <enabled location="2938d31d0913" resume="true" xmlns="urn:xmpp:sm:3" max="60" id="249b9c8a-ef2d-4c02-a468-84a09929d9f1"/>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 >> <iq id="rcN1n7g0vpiSLQ7gFw9FtjT" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 << <iq id="7lgwbydNJPV38KziDyi39yn" from="localhost" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10612/8871f720" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field type="hidden" var="FORM_TYPE"><value>http://jabber.org/network/serverinfo</value></field><field type="text-multi" var="abuse-addresses"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:encrypt:aes-128-gcm"/><feature var="tigase:push:filter:ignore-unknown:0"/><feature var="tigase:push:filter:groupchat:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:filter:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="jabber:iq:private"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/></query></iq>

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 << <iq id="rcN1n7g0vpiSLQ7gFw9FtjT" type="result" xmlns="jabber:client" to="user_petmyb0030@localhost/943755961-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-12-12 20:26:28 | Disconnecting

2019-12-12 20:26:28 | user :: user_petmyb0030@localhost/943755961-tigase-23 << <presence from="user_petmyb0030@localhost/943755961-tigase-23" xmlns="jabber:client" to="user_petmyb0030@localhost"><c node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" xmlns="http://jabber.org/protocol/caps" hash="sha-1"/></presence>

2019-12-12 20:26:28 | [Mutex] notify: [disconnected]

2019-12-12 20:26:28 | [Mutex] received everything.

2019-12-12 20:26:30 | [Mutex] waiting for: [user]

2019-12-12 20:26:30 | [Mutex] received everything.

2019-12-12 20:26:30 | [Mutex] isItemNotified: user:ok:true :: true