Brute Force Prevention

Test duration: 16.199s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 6.451s
2019-10-13 20:04:31 |

2019-10-13 20:04:31 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:04:31 | ------------------------------------

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@28107bc4

2019-10-13 20:04:31 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26d790b6}, 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@22e810b4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67ea9a8d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c0f03ef}, 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=Sun Oct 13 20:04:31 PDT 2019}}}}

2019-10-13 20:04:31 | [Mutex] waiting for: [registration]

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@56c778f8

2019-10-13 20:04:31 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26d790b6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@22e810b4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67ea9a8d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c0f03ef}, 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=Sun Oct 13 20:04:31 PDT 2019}}}}

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@34c8bf24

2019-10-13 20:04:31 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:31 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c565c2}

2019-10-13 20:04:31 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@33e11eae

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5e0cb092

2019-10-13 20:04:31 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2fcc15e8}

2019-10-13 20:04:31 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:31 | user :: null >> <iq to="localhost" id="MSqZ6lIygNXgyBgP8nfCnaA" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@51b9a2ea}

2019-10-13 20:04:31 | user :: null << <iq from="localhost" id="MSqZ6lIygNXgyBgP8nfCnaA" type="result" xmlns="jabber:client"><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-10-13 20:04:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@38b9ea6}

2019-10-13 20:04:31 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@3824e417

2019-10-13 20:04:31 | user :: null >> <iq to="localhost" id="tWADnfCnaAanW3t8Bxo2p4i" type="set"><query xmlns="jabber:iq:register"><username>user_f51nrq0019</username><password>user_f51nrq0019</password><email>2e9a4210-1d64-4df7-88b2-1da4aa1c2ecf@localhost</email></query></iq>

2019-10-13 20:04:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@d5b521a0}

2019-10-13 20:04:32 | user :: null << <iq from="localhost" id="tWADnfCnaAanW3t8Bxo2p4i" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:32 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3975ba1}

2019-10-13 20:04:32 | [Mutex] received everything.

2019-10-13 20:04:32 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:04:32 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c565c2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2fcc15e8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26d790b6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@22e810b4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67ea9a8d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c0f03ef}, 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=Sun Oct 13 20:04:32 PDT 2019}}}}

2019-10-13 20:04:32 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c565c2, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2fcc15e8]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26d790b6}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@22e810b4}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@67ea9a8d}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c0f03ef}, 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=Sun Oct 13 20:04:32 PDT 2019}}}}

2019-10-13 20:04:32 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@4c3b7d6e

2019-10-13 20:04:32 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@131aa4e1

2019-10-13 20:04:32 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@c81fec9

2019-10-13 20:04:32 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@35f2f6ab

2019-10-13 20:04:32 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@22b53d76

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1hbVRZRmdNcUxKNDZUZzAzNHQyMw==</auth>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hbVRZRmdNcUxKNDZUZzAzNHQyM0hrMWtaZkVBMHRmcWlJeUNwQnNvLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YW1UWUZnTXFMSjQ2VGcwMzR0MjNIazFrWmZFQTB0ZnFpSXlDcEJzbyxwPVc1VGcvWXRLT0RJaVhhWkE5bHB0VFJFU2ZJbHo5NS9FNy9jeFhmTngwcEU9</response>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0vMTVBdmN5NjJONTU2eEEwUWFzQmdkRWhjVkJqNTBtTGRwT05SOFp1TTZJPQ==</success>

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

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <iq xmlns="jabber:client" id="HZHIKKPUY4hAiKLT8i5eL07" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <iq id="HZHIKKPUY4hAiKLT8i5eL07" to="user_f51nrq0019@localhost/993927746-tigase-13" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_f51nrq0019@localhost/993927746-tigase-13</jid></bind></iq>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 >> <iq xmlns="jabber:client" id="BFHq2fRU9DAqbCoUXW0aBzu" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 << <iq id="BFHq2fRU9DAqbCoUXW0aBzu" to="user_f51nrq0019@localhost/993927746-tigase-13" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 >> <iq to="localhost" id="mQcEFGohCxydVY5AqQJEtjO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 << <enabled id="faf3daee-3916-4527-b528-68a20d0b8179" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 >> <iq id="yQaJIqTY7Bo7zsaFAkMHqY6" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 << <iq from="localhost" id="mQcEFGohCxydVY5AqQJEtjO" to="user_f51nrq0019@localhost/993927746-tigase-13" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="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-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 << <iq id="yQaJIqTY7Bo7zsaFAkMHqY6" to="user_f51nrq0019@localhost/993927746-tigase-13" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:32 | Disconnecting

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost/993927746-tigase-13 << <presence from="user_f51nrq0019@localhost/993927746-tigase-13" to="user_f51nrq0019@localhost" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-10-13 20:04:32 | [Mutex] notify: [disconnected]

2019-10-13 20:04:32 | [Mutex] received everything.

2019-10-13 20:04:32 | [Mutex] waiting for: [event]

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1uSFVvdnFLaWRVYWxSV3paTWN1OA==</auth>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1uSFVvdnFLaWRVYWxSV3paTWN1OEFnUHhLNVl0ajNoRjlHMG9icG9YLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bkhVb3ZxS2lkVWFsUld6Wk1jdThBZ1B4SzVZdGozaEY5RzBvYnBvWCxwPW9pdHl1eWplei9Kdk5IZ1FoKzRJcVcyTjdrb1Z1UWVzOGtEaUwyclI1MlE9</response>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:32 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:32 | [Mutex] received everything.

2019-10-13 20:04:32 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:32 | [Mutex] waiting for: [event]

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj0xVFl1UDlicjdzQUExOGNQdnY4eA==</auth>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xVFl1UDlicjdzQUExOGNQdnY4eGlCNDBwcmxTWFpHdnNMakdiTmtPLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MVRZdVA5YnI3c0FBMThjUHZ2OHhpQjQwcHJsU1haR3ZzTGpHYk5rTyxwPStUeXRaWkppSVhjUElvRXB5bnljd2FFR2ZYUG9XaHZsQzR3OUtyL0FXTjA9</response>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:32 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:32 | [Mutex] received everything.

2019-10-13 20:04:32 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:32 | [Mutex] waiting for: [event]

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:32 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1xRW5la21JclZrTWszNWJleTdxaQ==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xRW5la21JclZrTWszNWJleTdxaXROc1NROEUzODIwWEdQaTdvS0pjLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cUVuZWttSXJWa01rMzViZXk3cWl0TnNTUThFMzgyMFhHUGk3b0tKYyxwPXo2TGwxdmFrMnBNaUhJMnRPTzhrTWUxeDlrYUp6d0xQMzNJZzVab3JEazg9</response>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:33 | [Mutex] received everything.

2019-10-13 20:04:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:33 | [Mutex] waiting for: [event]

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj0wcmNrUmtlVFkySnpNR0RmbWNwQg==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wcmNrUmtlVFkySnpNR0RmbWNwQkZXRThRNFF3QzF4VXlsWmNLVXV6LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MHJja1JrZVRZMkp6TUdEZm1jcEJGV0U4UTRRd0MxeFV5bFpjS1V1eixwPXUwODI3ZlQ2VVdTVnJWM2RXZWV4MDRSMUFrMmdTcXZaQ0s0N25aclhJRTg9</response>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:33 | [Mutex] received everything.

2019-10-13 20:04:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:33 | [Mutex] waiting for: [event]

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1oQlNkV2hNRDhoanRwYTFweDdOQQ==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oQlNkV2hNRDhoanRwYTFweDdOQVZwN2JpS1lZSkV0a0V1M21WVk90LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aEJTZFdoTUQ4aGp0cGExcHg3TkFWcDdiaUtZWUpFdGtFdTNtVlZPdCxwPVNSYlhZOVBFRks0YlBERmhPS3dCbnV6VUZkZDB5REtPRTlCWndHdGlONGc9</response>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:33 | [Mutex] received everything.

2019-10-13 20:04:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:33 | [Mutex] notify: [event, disconnected]

2019-10-13 20:04:33 | [Mutex] waiting for: [event]

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj00STY1UzZEYVNWeW0xZ3dMTG91MQ==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00STY1UzZEYVNWeW0xZ3dMTG91MTJtcWwxNUlWV2hCaDl3NzZxVjBjLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NEk2NVM2RGFTVnltMWd3TExvdTEybXFsMTVJVldoQmg5dzc2cVYwYyxwPWVwbnBleHAvaE15TlExUmwwUlE4Rkhpc05rNHNxTGM1TW4rbi83NVFyTVE9</response>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:33 | [Mutex] received everything.

2019-10-13 20:04:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:33 | [Mutex] waiting for: [event]

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1pZkhYT0FON21HVzlvM3ZTazVxcA==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pZkhYT0FON21HVzlvM3ZTazVxcEUzVE9POTV5QkZJdmQxREpaT0g3LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aWZIWE9BTjdtR1c5bzN2U2s1cXBFM1RPTzk1eUJGSXZkMURKWk9INyxwPTZQVVpGSExBWWh4NFZLZUg4TnprNm5ZclgrblMyM2JtQUdDSGI3YUJNUWM9</response>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:33 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:33 | [Mutex] notify: [event, disconnected]

2019-10-13 20:04:33 | [Mutex] received everything.

2019-10-13 20:04:33 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:33 | [Mutex] waiting for: [event]

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj0weTkyRjd6bEVpREFjTWVhRmpRYg==</auth>

2019-10-13 20:04:33 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0weTkyRjd6bEVpREFjTWVhRmpRYkhuN2hDZ0Ewc2VjNHgyc1lEVUx4LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MHk5MkY3emxFaURBY01lYUZqUWJIbjdoQ2dBMHNlYzR4MnNZRFVMeCxwPVQzaHlMc1pPV2xPSVRhUnJRdmlBMjErU0xyZVdjUXhXVUh3NnIvNzFQbmM9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj15ZFRrRzhRSXFUMW1GSlJEdFc1ZQ==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15ZFRrRzhRSXFUMW1GSlJEdFc1ZWRpQnNNdnVncGhNOWZSTmxMODk4LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eWRUa0c4UUlxVDFtRkpSRHRXNWVkaUJzTXZ1Z3BoTTlmUk5sTDg5OCxwPWppTVZNRG9TU1A4SlB4d25yRU4vZzlmU3QrV2lmM2RsbWdjcDAxWW5qdEE9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1ZM1hlVWdlWnNEeTdmR2ltZ3BPdA==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZM1hlVWdlWnNEeTdmR2ltZ3BPdEVjVzJZTzRtOUI1VXIwODRxaElOLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WTNYZVVnZVpzRHk3ZkdpbWdwT3RFY1cyWU80bTlCNVVyMDg0cWhJTixwPVVqNm5RYmlsNXM5M3N1eTViSjVsTUtpTUNNR3A3Tm5CYllVK2dHS1V0dnc9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1rcWk4eXV6YjVjVXU5bWlyMEFpVw==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rcWk4eXV6YjVjVXU5bWlyMEFpV2FwUnpiNzBFUGE1TDJ4ZzJVT1doLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a3FpOHl1emI1Y1V1OW1pcjBBaVdhcFJ6YjcwRVBhNUwyeGcyVU9XaCxwPWd0UGhvVExyOEp1MUt3WTBTRnl2M3ZuZjhrMmhUb0tqQ1Q3cUpLdkdZTXc9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1nUkNMcmN3SVVVQUpKRjdWN3ppeg==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1nUkNMcmN3SVVVQUpKRjdWN3ppelg2eEcyUngxQWZHbXA1TVZqZ1dTLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z1JDTHJjd0lVVUFKSkY3Vjd6aXpYNnhHMlJ4MUFmR21wNU1WamdXUyxwPVdXVHFVQTY4enFvWmE5MnhhY3pONTAwVk12VFlFdGdXVHQ1YUd4RjVlTU09</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj0zcnNiZldCajZFYmRiWXV3eXVZMg==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zcnNiZldCajZFYmRiWXV3eXVZMmpiZTlWVjdvelVsS0pKSlRDbVdqLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M3JzYmZXQmo2RWJkYll1d3l1WTJqYmU5VlY3b3pVbEtKSkpUQ21XaixwPTNMbnJPdWN2QlNjVmFMSUZEczZLb0MzcXdmamQwaW9JTTVydFBHakxlY1k9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] notify: [event, disconnected]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1OWE9TbEdKRk9zMzJVcUVIQmc1dA==</auth>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OWE9TbEdKRk9zMzJVcUVIQmc1dEJZak1UdVlMcUN5Y1h0ZG5Ea2dGLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TlhPU2xHSkZPczMyVXFFSEJnNXRCWWpNVHVZTHFDeWNYdGRuRGtnRixwPUtmckhBb1ExZFcxL21mWWQ0Q2Y0M1k4Y0dpM3JqaFlvYjZudnlrV3l1ZFU9</response>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:34 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:34 | [Mutex] received everything.

2019-10-13 20:04:34 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:34 | [Mutex] waiting for: [event]

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:34 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1yUExCUG5qaGxQRFdGclJudGdpcg==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1yUExCUG5qaGxQRFdGclJudGdpcjZmZUJCdmYyMTQ4eHl1WW9yU2ROLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9clBMQlBuamhsUERXRnJSbnRnaXI2ZmVCQnZmMjE0OHh5dVlvclNkTixwPWlabVlYTVA1YW9FWGxRUDNLRHY0YXp6Umh0TFkvcVVjQ0g4ZENtVm5VcWs9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1sTFJXRUJnR0s1aE5Sb1V0bGpBOA==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sTFJXRUJnR0s1aE5Sb1V0bGpBOHZka3JVV3d3ekUwTjBHa2IyWFNZLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bExSV0VCZ0dLNWhOUm9VdGxqQTh2ZGtyVVd3d3pFME4wR2tiMlhTWSxwPUpwbUNnRTFvN090QUIrc0c4K2o3Z2RXRHN6RjFJSGFRMGtOSjluZmk4R1E9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1SUHpTQ1RsRDJXTHVyeHBaSVpWeQ==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SUHpTQ1RsRDJXTHVyeHBaSVpWeVVnS1d0MWd6Wm9OYXZ0eHBpR0F2LHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UlB6U0NUbEQyV0x1cnhwWklaVnlVZ0tXdDFnelpvTmF2dHhwaUdBdixwPXpYZ3NPVVg0djQ1ajgxTDlTaG9wUFlIbW9pbW0vRnpROU1VTFRiOGpxRVE9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj00NTRZZXJ0NzdGa2Q2MmtIUjhxOQ==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00NTRZZXJ0NzdGa2Q2MmtIUjhxOXE4UThPSnlHVXAxYXVjYTN4MzNHLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NDU0WWVydDc3RmtkNjJrSFI4cTlxOFE4T0p5R1VwMWF1Y2EzeDMzRyxwPTVVdGtWNGN4anNVenZ0VVhnSlRxUFVRZS95NEVVeDJiZ2h4ZEFraTUvUDA9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1iT0RhblVXVHNWM1g0TUs0RDFxZg==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1iT0RhblVXVHNWM1g0TUs0RDFxZmI5M3VNZjV3TG9YQ0FPZVFRa0RLLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Yk9EYW5VV1RzVjNYNE1LNEQxcWZiOTN1TWY1d0xvWENBT2VRUWtESyxwPVFNNkFnalIxK3YvNUQveUpiZUh2bFBSNlFFUXQ3amtFbXJiNVd4Q2gxMjQ9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj1Kc3RkV1RzM0E4RGlZdDBhaUtUMQ==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Kc3RkV1RzM0E4RGlZdDBhaUtUMW9yeTR0cnVSeGpzb054ZVBMazgzLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9SnN0ZFdUczNBOERpWXQwYWlLVDFvcnk0dHJ1Unhqc29OeGVQTGs4MyxwPVpNY1FMOEgwcjVEY3BHN2VhUWt0cFRvOUMxMnQ3bUQ1T3V6ajBIZlNYNUE9</response>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:35 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:35 | [Mutex] received everything.

2019-10-13 20:04:35 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:35 | [Mutex] waiting for: [event]

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj15VU9GaVE1N2wzOW91eW1TUVZuYw==</auth>

2019-10-13 20:04:35 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15VU9GaVE1N2wzOW91eW1TUVZuY3g4YmdSc1BiV1Jpc2ViclZ4c1hCLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eVVPRmlRNTdsMzlvdXltU1FWbmN4OGJnUnNQYldSaXNlYnJWeHNYQixwPUw4US9WOHBmZ1FFTW9WSFBUVVZCN3pCTlpYcFRGL2tPSVF2OWMyTmdpU0U9</response>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:36 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:36 | [Mutex] received everything.

2019-10-13 20:04:36 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Y1MW5ycTAwMTkscj0yRGMzWFZnTnNSZ01ZSXVUWGZXSQ==</auth>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yRGMzWFZnTnNSZ01ZSXVUWGZXSWh4aDRDS0VaUFVmNU9KcFkyc24yLHM9UWZCSXVQcXY1WXVKZmc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkRjM1hWZ05zUmdNWUl1VFhmV0loeGg0Q0tFWlBVZjVPSnBZMnNuMixwPWVwMXBLQ0N5S3d5QVZVd2kxTG5LSUF0VkJhUzQrQ3BCaEI5anNjMllVYXc9</response>

2019-10-13 20:04:36 | user :: user_f51nrq0019@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_f51nrq0019@localhost is not authorized to act as user_f51nrq0019@localhost</text></failure>

2019-10-13 20:04:38 | [Mutex] waiting for: [user]

2019-10-13 20:04:38 | [Mutex] received everything.

2019-10-13 20:04:38 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.061s
2019-10-13 20:04:38 |

2019-10-13 20:04:38 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:04:38 | ------------------------------------

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@57a44b51

2019-10-13 20:04:38 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5963bfd5}, 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@5d5c2021}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@185eb5ee}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6dd59b77}, 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=Sun Oct 13 20:04:38 PDT 2019}}}}

2019-10-13 20:04:38 | [Mutex] waiting for: [registration]

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@298c0c0f

2019-10-13 20:04:38 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5963bfd5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@5d5c2021}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@185eb5ee}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6dd59b77}, 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=Sun Oct 13 20:04:38 PDT 2019}}}}

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@15ed7c37

2019-10-13 20:04:38 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78714aa1}

2019-10-13 20:04:38 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:38 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@393e68fb

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@709bf7a7

2019-10-13 20:04:38 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ee93147}

2019-10-13 20:04:38 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:38 | user :: null >> <iq to="localhost" id="40y5dCpbyrdKKPUY4hAiKLT" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@18363403}

2019-10-13 20:04:38 | user :: null << <iq from="localhost" id="40y5dCpbyrdKKPUY4hAiKLT" type="result" xmlns="jabber:client"><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-10-13 20:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7c3f5679}

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@368c80b5

2019-10-13 20:04:38 | user :: null >> <iq to="localhost" id="f6ORSSTOKEzvmKZ2nezDoVg" type="set"><query xmlns="jabber:iq:register"><username>user_e7qllu0020</username><password>user_e7qllu0020</password><email>22b7722e-0fc8-49be-831d-605eaaff1624@localhost</email></query></iq>

2019-10-13 20:04:38 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e0d6732}

2019-10-13 20:04:38 | user :: null << <iq from="localhost" id="f6ORSSTOKEzvmKZ2nezDoVg" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:38 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@19056f0c}

2019-10-13 20:04:38 | [Mutex] received everything.

2019-10-13 20:04:38 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:04:38 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78714aa1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ee93147]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5963bfd5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@5d5c2021}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@185eb5ee}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6dd59b77}, 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=Sun Oct 13 20:04:38 PDT 2019}}}}

2019-10-13 20:04:38 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@78714aa1, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@ee93147]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5963bfd5}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@5d5c2021}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@185eb5ee}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@6dd59b77}, 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=Sun Oct 13 20:04:38 PDT 2019}}}}

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5e211662

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@58ab1f41

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@a70a5c9

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@38bfc684

2019-10-13 20:04:38 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6efb55f7

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj1xb1VsOXRoUDlRQjN4OG94RjJrTQ==</auth>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xb1VsOXRoUDlRQjN4OG94RjJrTVFZaUl6eGlWdmdMbVByd2RPYmZjLHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cW9VbDl0aFA5UUIzeDhveEYya01RWWlJenhpVnZnTG1QcndkT2JmYyxwPTZyNE1Gb2NLZHZVekg5SXI2UEI2a1B0Q0xMcHU3bHI5VzAyR3lRdWROSlU9</response>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1IaVdtaUJHOEhyOUZiSmF2aDVrL3NPanJRYS82Y1YvaGQ2a2JqUlNOSzVvPQ==</success>

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

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <iq xmlns="jabber:client" id="99V1n5ueNQQOLyeCvn6eXYf" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <iq id="99V1n5ueNQQOLyeCvn6eXYf" to="user_e7qllu0020@localhost/993927746-tigase-14" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_e7qllu0020@localhost/993927746-tigase-14</jid></bind></iq>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 >> <iq xmlns="jabber:client" id="H8Q0kU9ygErUW2l3sWnOVkL" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 << <iq id="H8Q0kU9ygErUW2l3sWnOVkL" to="user_e7qllu0020@localhost/993927746-tigase-14" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 >> <iq to="localhost" id="f9RX4gFmQQXhUQbq9MFPMHO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 << <enabled id="19092e13-5659-4256-863f-d80202d2c2f4" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 >> <iq id="ocYhAFo5EpjKDGCevczvcJN" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 << <iq from="localhost" id="f9RX4gFmQQXhUQbq9MFPMHO" to="user_e7qllu0020@localhost/993927746-tigase-14" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="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-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 << <iq id="ocYhAFo5EpjKDGCevczvcJN" to="user_e7qllu0020@localhost/993927746-tigase-14" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:38 | Disconnecting

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost/993927746-tigase-14 << <presence from="user_e7qllu0020@localhost/993927746-tigase-14" to="user_e7qllu0020@localhost" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-10-13 20:04:38 | [Mutex] notify: [disconnected]

2019-10-13 20:04:38 | [Mutex] received everything.

2019-10-13 20:04:38 | [Mutex] waiting for: [event]

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj12dDkxRHhZYlRuVEJUNDlqT0dMTg==</auth>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12dDkxRHhZYlRuVEJUNDlqT0dMTkdnTjd5M1hlVEpuWGFEVkpRU3I5LHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dnQ5MUR4WWJUblRCVDQ5ak9HTE5HZ043eTNYZVRKblhhRFZKUVNyOSxwPWNDTGtGcklIMXd1OXoxYUJxK2t4M25tMHdOYm1rcTVZYWFWdHpjclcyZXc9</response>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:38 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:38 | [Mutex] received everything.

2019-10-13 20:04:38 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:38 | [Mutex] waiting for: [event]

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj1wOXpXM01OQXJqa0Z0NkF4bHF2aQ==</auth>

2019-10-13 20:04:38 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wOXpXM01OQXJqa0Z0NkF4bHF2aU0zS1ZUNGRLMzdRbTA4RmdrYWg5LHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cDl6VzNNTkFyamtGdDZBeGxxdmlNM0tWVDRkSzM3UW0wOEZna2FoOSxwPXpXdm1kK0JDQXJPYUNiV0k3Q3F5amgzZHcxN0EzdUVQZnBHclZIN2s0Wkk9</response>

2019-10-13 20:04:39 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:39 | [Mutex] received everything.

2019-10-13 20:04:39 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:39 | [Mutex] waiting for: [event]

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj1DSEF3WmJmRzNaaGhlcEhtQWV2ZQ==</auth>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DSEF3WmJmRzNaaGhlcEhtQWV2ZXdSQW5SeHpKYXEyeVBIYVc3azR1LHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q0hBd1piZkczWmhoZXBIbUFldmV3UkFuUnh6SmFxMnlQSGFXN2s0dSxwPTRXOXM3bFdsVXgrRmJWcklZdTNteHB1eUxHaGFUM3dQdUlvWjNCenFiMEU9</response>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:39 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:39 | [Mutex] received everything.

2019-10-13 20:04:39 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:39 | [Mutex] waiting for: [event]

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj12RHhtTTRyQlNSeG92a0JEcG9Zaw==</auth>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12RHhtTTRyQlNSeG92a0JEcG9Za2xYc1Zob0ptNDRva2wxUVNQY0pwLHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkR4bU00ckJTUnhvdmtCRHBvWWtsWHNWaG9KbTQ0b2tsMVFTUGNKcCxwPTNWTGxxSXhXVm5GZUw0NU1yT1llTWd3R0dDTXZhTTBiNXVYcVhpbXNDSmM9</response>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:39 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:39 | [Mutex] received everything.

2019-10-13 20:04:39 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2U3cWxsdTAwMjAscj16VVl6ajNYOGFEdFF6MUIxWkFkWQ==</auth>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16VVl6ajNYOGFEdFF6MUIxWkFkWVYwMWlKbTQwOVl6Y1lOcjVvNlU5LHM9TjNZNHBWR0xtSWtJZnc9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9elVZemozWDhhRHRRejFCMVpBZFlWMDFpSm00MDlZemNZTnI1bzZVOSxwPVFxWGZDN0U2dHpCd0RaaGl4bVZhRVlQd1lwWERlRnRlMnJZSGFXSWNoZ0E9</response>

2019-10-13 20:04:39 | user :: user_e7qllu0020@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:41 | [Mutex] waiting for: [user]

2019-10-13 20:04:41 | [Mutex] received everything.

2019-10-13 20:04:41 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.194s
2019-10-13 20:04:41 |

2019-10-13 20:04:41 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:04:41 | ------------------------------------

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@6cb23c97

2019-10-13 20:04:41 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6275df71}, 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@664a57e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2348d54a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e630330}, 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=Sun Oct 13 20:04:41 PDT 2019}}}}

2019-10-13 20:04:41 | [Mutex] waiting for: [registration]

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1221d1da

2019-10-13 20:04:41 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6275df71}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@664a57e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2348d54a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e630330}, 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=Sun Oct 13 20:04:41 PDT 2019}}}}

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@26e05916

2019-10-13 20:04:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:41 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43672a05}

2019-10-13 20:04:41 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@55bcbda

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@196875aa

2019-10-13 20:04:41 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3de4b778}

2019-10-13 20:04:41 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:41 | user :: null >> <iq to="localhost" id="dcSZjSUW14gGDDCg16vu5Fs" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:04:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ea1c29a2}

2019-10-13 20:04:41 | user :: null << <iq from="localhost" id="dcSZjSUW14gGDDCg16vu5Fs" type="result" xmlns="jabber:client"><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-10-13 20:04:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@472995c3}

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@1c7783e7

2019-10-13 20:04:41 | user :: null >> <iq to="localhost" id="feW7oUXW0aBzu0v4rmP9qZo" type="set"><query xmlns="jabber:iq:register"><username>user_ysjxm50021</username><password>user_ysjxm50021</password><email>1a89aeaf-a222-4f99-8af2-0f66b2d1972b@localhost</email></query></iq>

2019-10-13 20:04:41 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1c24e3a1}

2019-10-13 20:04:41 | user :: null << <iq from="localhost" id="feW7oUXW0aBzu0v4rmP9qZo" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:41 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@46e860e6}

2019-10-13 20:04:41 | [Mutex] received everything.

2019-10-13 20:04:41 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:04:41 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43672a05, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3de4b778]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6275df71}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@664a57e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2348d54a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e630330}, 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=Sun Oct 13 20:04:41 PDT 2019}}}}

2019-10-13 20:04:41 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@43672a05, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3de4b778]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6275df71}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@664a57e7}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2348d54a}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5e630330}, 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=Sun Oct 13 20:04:41 PDT 2019}}}}

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@5e2f4034

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@55a351bf

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@756b9857

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7081294c

2019-10-13 20:04:41 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@540be988

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lzanhtNTAwMjEscj01YVd3M092RzFYbzRzblZBUmRTTQ==</auth>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01YVd3M092RzFYbzRzblZBUmRTTUlaTlRVV0ZweVA5bkdIcFhNcERmLHM9TllUZnVERWRUcVBoV2c9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NWFXdzNPdkcxWG80c25WQVJkU01JWk5UVVdGcHlQOW5HSHBYTXBEZixwPWFpK3VYMThEVTVPQ0VMK3lNSUl0REZDUUVsOE5IdlI5dlN1MFZQWnRDTlE9</response>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1YQnZ1aHE3NEJ1RGwxL0RmRWt1b1dyTVRtdVNucXRIRHFHUjN4eDI3ckZNPQ==</success>

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

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost >> <iq xmlns="jabber:client" id="TbLS6eXYfY3BkN0gw5mT9uj" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <iq id="TbLS6eXYfY3BkN0gw5mT9uj" to="user_ysjxm50021@localhost/993927746-tigase-15" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_ysjxm50021@localhost/993927746-tigase-15</jid></bind></iq>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 >> <iq xmlns="jabber:client" id="WX3AeL07JAj2kElSVdCztgM" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 << <iq id="WX3AeL07JAj2kElSVdCztgM" to="user_ysjxm50021@localhost/993927746-tigase-15" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 >> <iq to="localhost" id="5WYY8rfGHJMOXau6lIygNXg" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 << <enabled id="2160a7eb-fb0b-4424-b0b2-d56412e4604d" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 >> <iq id="Y1bEMFPMHOSKxgHLILR2kZe" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 << <iq from="localhost" id="5WYY8rfGHJMOXau6lIygNXg" to="user_ysjxm50021@localhost/993927746-tigase-15" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="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-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 << <iq id="Y1bEMFPMHOSKxgHLILR2kZe" to="user_ysjxm50021@localhost/993927746-tigase-15" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:41 | Disconnecting

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost/993927746-tigase-15 << <presence from="user_ysjxm50021@localhost/993927746-tigase-15" to="user_ysjxm50021@localhost" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-10-13 20:04:41 | [Mutex] notify: [disconnected]

2019-10-13 20:04:41 | [Mutex] received everything.

2019-10-13 20:04:41 | [Mutex] waiting for: [event]

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:41 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lzanhtNTAwMjEscj0xS3Y5aTEzQml2RVJ6aTJObG53Tg==</auth>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xS3Y5aTEzQml2RVJ6aTJObG53TnZQQktPZjhFV0hRRzRGUTA1VkVOLHM9TllUZnVERWRUcVBoV2c9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MUt2OWkxM0JpdkVSemkyTmxud052UEJLT2Y4RVdIUUc0RlEwNVZFTixwPXhqYUllb0ZqOHZxM1FXNk5YODRwUjhhWFhIbVkzandlU24xUlFqV1E0YkE9</response>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:42 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:42 | [Mutex] received everything.

2019-10-13 20:04:42 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:42 | [Mutex] waiting for: [event]

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeXNqeG01MDAyMQAgLSAtIC0gLSAt</auth>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:42 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:42 | [Mutex] received everything.

2019-10-13 20:04:42 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:42 | [Mutex] waiting for: [event]

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeXNqeG01MDAyMQAgLSAtIC0gLSAt</auth>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:42 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:42 | [Mutex] received everything.

2019-10-13 20:04:42 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:42 | [Mutex] waiting for: [event]

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfeXNqeG01MDAyMQAgLSAtIC0gLSAt</auth>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:42 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:42 | [Mutex] received everything.

2019-10-13 20:04:42 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:42 | [Mutex] notify: [event, disconnected]

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3lzanhtNTAwMjEscj1TM0gyWG1PbkRLdVkzclJzODVhRg==</auth>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TM0gyWG1PbkRLdVkzclJzODVhRnpuQUVlUE5zZVFMZldnYXFjWHk4LHM9TllUZnVERWRUcVBoV2c9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzNIMlhtT25ES3VZM3JSczg1YUZ6bkFFZVBOc2VRTGZXZ2FxY1h5OCxwPWdrUE5PcDRoOSs2U3kzRlN3UU9NV3RFUTVqekczOUpsQjN1RWM0RDE0N2s9</response>

2019-10-13 20:04:42 | user :: user_ysjxm50021@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:44 | [Mutex] waiting for: [user]

2019-10-13 20:04:44 | [Mutex] received everything.

2019-10-13 20:04:44 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.080s
2019-10-13 20:04:44 |

2019-10-13 20:04:44 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-10-13 20:04:44 | ------------------------------------

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5343acea

2019-10-13 20:04:44 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5d8458f2}, 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@59bbc79a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1cb952c9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52d39948}, 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=Sun Oct 13 20:04:44 PDT 2019}}}}

2019-10-13 20:04:44 | [Mutex] waiting for: [registration]

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2d6f0828

2019-10-13 20:04:44 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5d8458f2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@59bbc79a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1cb952c9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52d39948}, 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=Sun Oct 13 20:04:44 PDT 2019}}}}

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@2aef9d08

2019-10-13 20:04:44 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c96ad86}

2019-10-13 20:04:44 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:44 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@32c16285

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@67ba02bd

2019-10-13 20:04:44 | user :: null << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31ebd49f}

2019-10-13 20:04:44 | StreamFeaturesReceivedEvent[<features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>]

2019-10-13 20:04:44 | user :: null >> <iq to="localhost" id="ThR4u0v4rmP9qZo24byhV2p" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-10-13 20:04:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@3589c4d0}

2019-10-13 20:04:44 | user :: null << <iq from="localhost" id="ThR4u0v4rmP9qZo24byhV2p" type="result" xmlns="jabber:client"><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-10-13 20:04:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@78d8b5b9}

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4134356d

2019-10-13 20:04:44 | user :: null >> <iq to="localhost" id="AhQElSVdCztgMT2eAjEq0hV" type="set"><query xmlns="jabber:iq:register"><username>user_xt27z50022</username><password>user_xt27z50022</password><email>52ad7afa-8444-433e-87a0-349790876c0f@localhost</email></query></iq>

2019-10-13 20:04:44 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@680de5f1}

2019-10-13 20:04:44 | user :: null << <iq from="localhost" id="AhQElSVdCztgMT2eAjEq0hV" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:44 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@762c681c}

2019-10-13 20:04:44 | [Mutex] received everything.

2019-10-13 20:04:44 | [Mutex] isItemNotified: registrationSuccess :: true

2019-10-13 20:04:44 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c96ad86, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31ebd49f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5d8458f2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@59bbc79a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1cb952c9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52d39948}, 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=Sun Oct 13 20:04:44 PDT 2019}}}}

2019-10-13 20:04:44 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=session, value=[Ljavax.net.ssl.X509TrustManager;@196ecc71}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7c96ad86, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@31ebd49f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5d8458f2}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@310950d6}, 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@59bbc79a}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1cb952c9}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@52d39948}, 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=Sun Oct 13 20:04:44 PDT 2019}}}}

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@190c056a

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@24440e8f

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@44bbc837

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@51c22434

2019-10-13 20:04:44 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@289c5c33

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h0Mjd6NTAwMjIscj16YWhjVk9zNHJvaVpmVUxub1FLSg==</auth>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16YWhjVk9zNHJvaVpmVUxub1FLSjJlZVkxcWFtMWh1MTJKSTA2VGYwLHM9YW1oV3JOaktsQ1l0RVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9emFoY1ZPczRyb2laZlVMbm9RS0oyZWVZMXFhbTFodTEySkkwNlRmMCxwPWtldVBCSnY0bmR5SzArU3RTbm9vU252SndseWN3UzlNajdBNFNpZ1NaRVk9</response>

2019-10-13 20:04:44 | user :: user_xt27z50022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0rNWExcWRXNGFCUDVGN2U0bkNHaG9tcms0UExlRTNOOVJuZU9DRkNjRmNzPQ==</success>

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

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <iq xmlns="jabber:client" id="po9i5eL07JAj2kElSVdCztg" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <iq id="po9i5eL07JAj2kElSVdCztg" to="user_xt27z50022@localhost/993927746-tigase-16" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_xt27z50022@localhost/993927746-tigase-16</jid></bind></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 >> <iq xmlns="jabber:client" id="9qdAvl0gRY6kNCmS1pamduh" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 << <iq id="9qdAvl0gRY6kNCmS1pamduh" to="user_xt27z50022@localhost/993927746-tigase-16" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 >> <iq to="localhost" id="cp8ym3mSSTOKEzvmKZ2nezD" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 << <enabled id="8ebcfde3-d871-4d74-b351-05aeb0b2cd34" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 >> <iq id="DhIzvcJNU4tcyeBeAkVdMAF" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 << <iq from="localhost" id="cp8ym3mSSTOKEzvmKZ2nezD" to="user_xt27z50022@localhost/993927746-tigase-16" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="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-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 << <iq id="DhIzvcJNU4tcyeBeAkVdMAF" to="user_xt27z50022@localhost/993927746-tigase-16" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:45 | Disconnecting

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-16 << <presence from="user_xt27z50022@localhost/993927746-tigase-16" to="user_xt27z50022@localhost" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-10-13 20:04:45 | [Mutex] notify: [disconnected]

2019-10-13 20:04:45 | [Mutex] received everything.

2019-10-13 20:04:45 | [Mutex] waiting for: [event]

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h0Mjd6NTAwMjIscj11eUc1eWtZODdKWUtab1ZSUnVQMg==</auth>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11eUc1eWtZODdKWUtab1ZSUnVQMjFrbk80bEVqZEtSNXRqb1Z4N0xELHM9YW1oV3JOaktsQ1l0RVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dXlHNXlrWTg3SllLWm9WUlJ1UDIxa25PNGxFamRLUjV0am9WeDdMRCxwPVhUYTBWSkpMWURCVkxJS29kd3Y5dWZnNVhlTkx1UitaS2xCUDNQMElBU2M9</response>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:45 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:45 | [Mutex] received everything.

2019-10-13 20:04:45 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:45 | [Mutex] waiting for: [event]

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h0Mjd6NTAwMjIscj1xbEdYMndLcWF6cjhJSXYycWNPSw==</auth>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xbEdYMndLcWF6cjhJSXYycWNPS1NvQmtiS3RuYmdZbXhkd3lxZjJvLHM9YW1oV3JOaktsQ1l0RVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cWxHWDJ3S3FhenI4SUl2MnFjT0tTb0JrYkt0bmJnWW14ZHd5cWYybyxwPXZFNU04bHJCMW0zc0hUS2dwZ2lWYlM2NFFjMGJDcWplcUcyMHFSVm9rZlU9</response>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:45 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:45 | [Mutex] received everything.

2019-10-13 20:04:45 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:45 | [Mutex] waiting for: [event]

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h0Mjd6NTAwMjIscj01c0FQZHNkVlRGYURDQ3p4WDlJOA==</auth>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj01c0FQZHNkVlRGYURDQ3p4WDlJOE1nb1FLdmJva3hxVGNxeEpLU05HLHM9YW1oV3JOaktsQ1l0RVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NXNBUGRzZFZURmFEQ0N6eFg5SThNZ29RS3Zib2t4cVRjcXhKS1NORyxwPVVSZnV0QjlKQm9rMnJSWFNxelBiRThNQzQ5VmJaY0pqbEFQTGFxUW0wY1E9</response>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-10-13 20:04:45 | [Mutex] notify: [event, authFailed]

2019-10-13 20:04:45 | [Mutex] received everything.

2019-10-13 20:04:45 | [Mutex] isItemNotified: authFailed :: true

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"/><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"><required/></starttls><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <features xmlns="http://etherx.jabber.org/streams"><sm xmlns="urn:xmpp:sm:3"/><auth xmlns="http://jabber.org/features/iq-auth"/><register xmlns="http://jabber.org/features/iq-register"/><mechanisms xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><mechanism>SCRAM-SHA-256</mechanism><mechanism>SCRAM-SHA-1</mechanism><mechanism>PLAIN</mechanism><mechanism>ANONYMOUS</mechanism></mechanisms><ver xmlns="urn:xmpp:features:rosterver"/><sub xmlns="urn:xmpp:features:pre-approval"/><compression xmlns="http://jabber.org/features/compress"><method>zlib</method></compression></features>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3h0Mjd6NTAwMjIscj1Uc3dqTDhYaWpBd0Q1MFlOWkY2bA==</auth>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Uc3dqTDhYaWpBd0Q1MFlOWkY2bHJRYm5sYUp1Z1FndENSMWZhQUFGLHM9YW1oV3JOaktsQ1l0RVE9PSxpPTQwOTY=</challenge>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VHN3akw4WGlqQXdENTBZTlpGNmxyUWJubGFKdWdRZ3RDUjFmYUFBRixwPTdwa25MbldYemZpV3h6V1pGczl1L3pLRjcwRzBOVHNJanJNdUw4RHFCYzQ9</response>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1OaVVUbFVSekRsbm9BSEVnNEJKR1JJYncxMWpFenJGbUttY1VGWG9sMFRRPQ==</success>

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

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost >> <iq xmlns="jabber:client" id="UtgQIVU7IxzgFKKu1eDDsfP" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost << <iq id="UtgQIVU7IxzgFKKu1eDDsfP" to="user_xt27z50022@localhost/993927746-tigase-17" type="result" xmlns="jabber:client"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_xt27z50022@localhost/993927746-tigase-17</jid></bind></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 >> <iq xmlns="jabber:client" id="GjKNVaAvgGu7gEsbJOENEBG" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 << <iq id="GjKNVaAvgGu7gEsbJOENEBG" to="user_xt27z50022@localhost/993927746-tigase-17" type="result" xmlns="jabber:client"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 >> <iq to="localhost" id="ItcGCzoW09kMIHLSM3aDKBH" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 << <enabled id="f6374771-b4c0-4862-8638-8837ffcb9989" max="60" location="d4270859fb27" xmlns="urn:xmpp:sm:3" resume="true"/>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 >> <iq id="Ydo3Ah3eBCuYZavnWdLQWdG" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 << <iq from="localhost" id="ItcGCzoW09kMIHLSM3aDKBH" to="user_xt27z50022@localhost/993927746-tigase-17" type="result" xmlns="jabber:client"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10535/f55efd39" category="server" type="im"/><feature var="http://jabber.org/protocol/commands"/><x type="result" xmlns="jabber:x:data"><field var="FORM_TYPE" type="hidden"><value>http://jabber.org/network/serverinfo</value></field><field var="abuse-addresses" type="text-multi"><value>mailto:abuse@localhost</value><value>xmpp:abuse@localhost</value></field></x><feature var="urn:xmpp:carbons:2"/><feature var="http://jabber.org/protocol/stats"/><feature var="vcard-temp"/><feature var="jabber:iq:auth"/><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="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-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 << <iq id="Ydo3Ah3eBCuYZavnWdLQWdG" to="user_xt27z50022@localhost/993927746-tigase-17" type="result" xmlns="jabber:client"><query xmlns="jabber:iq:roster"/></iq>

2019-10-13 20:04:45 | Disconnecting

2019-10-13 20:04:45 | user :: user_xt27z50022@localhost/993927746-tigase-17 << <presence from="user_xt27z50022@localhost/993927746-tigase-17" to="user_xt27z50022@localhost" xmlns="jabber:client"><c ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1" node="http://tigase.org/jaxmpp" xmlns="http://jabber.org/protocol/caps"/></presence>

2019-10-13 20:04:45 | [Mutex] notify: [disconnected]

2019-10-13 20:04:45 | [Mutex] received everything.

2019-10-13 20:04:47 | [Mutex] waiting for: [user]

2019-10-13 20:04:47 | [Mutex] received everything.

2019-10-13 20:04:47 | [Mutex] isItemNotified: user:ok:true :: true