Brute Force Prevention

Test duration: 14.884s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.301s
2019-11-22 20:25:23 |

2019-11-22 20:25:23 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 20:25:23 | ------------------------------------

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@49d5c246

2019-11-22 20:25:23 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4712250c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@432da936}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@62f2f37}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@618f1a46}, 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=Fri Nov 22 20:25:23 PST 2019}}}}

2019-11-22 20:25:23 | [Mutex] waiting for: [registration]

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@3763693e

2019-11-22 20:25:23 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4712250c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@432da936}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@62f2f37}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@618f1a46}, 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=Fri Nov 22 20:25:23 PST 2019}}}}

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@192902fd

2019-11-22 20:25:23 | 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-11-22 20:25:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6600d078}

2019-11-22 20:25:23 | 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-11-22 20:25:23 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7f44bbd4

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@53c2179b

2019-11-22 20:25:23 | 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-11-22 20:25:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@22dc9f4}

2019-11-22 20:25:23 | 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-11-22 20:25:23 | user :: null >> <iq to="localhost" id="aHmaFyeRW3mYk2aNSeQ1ocP" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 20:25:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@91bd7115}

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@624e4ad9

2019-11-22 20:25:23 | user :: null << <iq from="localhost" xmlns="jabber:client" id="aHmaFyeRW3mYk2aNSeQ1ocP" type="result"><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-11-22 20:25:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@380ec75f}

2019-11-22 20:25:23 | user :: null >> <iq to="localhost" id="rKtgWj5n6cOS6yx4aDKPSS9" type="set"><query xmlns="jabber:iq:register"><username>user_jqpbkq0027</username><password>user_jqpbkq0027</password><email>56f5a732-821f-4351-9e2f-05eafd14558c@localhost</email></query></iq>

2019-11-22 20:25:23 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ab00fa73}

2019-11-22 20:25:23 | user :: null << <iq from="localhost" xmlns="jabber:client" id="rKtgWj5n6cOS6yx4aDKPSS9" type="result"/>

2019-11-22 20:25:23 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7b33610a}

2019-11-22 20:25:23 | [Mutex] received everything.

2019-11-22 20:25:23 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 20:25:23 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6600d078, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@22dc9f4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4712250c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@432da936}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@62f2f37}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@618f1a46}, 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=Fri Nov 22 20:25:23 PST 2019}}}}

2019-11-22 20:25:23 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@6600d078, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@22dc9f4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@4712250c}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@432da936}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@62f2f37}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@618f1a46}, 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=Fri Nov 22 20:25:23 PST 2019}}}}

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@17bd75f1

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7b5ed5d

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@494fe6cb

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@2914f5d9

2019-11-22 20:25:23 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@55fa0ff7

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj05UGdxQ1dEOGVRcERJNE14YUhsaQ==</auth>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj05UGdxQ1dEOGVRcERJNE14YUhsaWJFRFNqM1NiZzNTM2k2NHd2eWx5LHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9OVBncUNXRDhlUXBESTRNeGFIbGliRURTajNTYmczUzNpNjR3dnlseSxwPUpNMnZJaUorYlJNdXNtL3plbHZXcEVEelphRVZ3RE0rdmtlMGF6ZkJ1ZHc9</response>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1iaHUzeEk3c3NmS056M3l2cjA3OFQ2K0hCak45U0NFUjg5cU82RDAxWng0PQ==</success>

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

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <iq xmlns="jabber:client" id="uRMZbIqgMUaLw4rm3kMX8r8" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <iq xmlns="jabber:client" to="user_jqpbkq0027@localhost/993927746-tigase-19" id="uRMZbIqgMUaLw4rm3kMX8r8" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_jqpbkq0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="OHgKS8mbEMWdMYndDCeS0m4" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_jqpbkq0027@localhost/993927746-tigase-19" id="OHgKS8mbEMWdMYndDCeS0m4" type="result"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="ysvo2qcPEkXo7s2tavgMWgC" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 << <enabled max="60" xmlns="urn:xmpp:sm:3" resume="true" id="ccab0c30-ebbe-4f52-bb7f-e7a3c5b66269" location="d4270859fb27"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 >> <iq id="wG9CeS0m4z8iTgRW0p2fKKS" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 << <iq from="localhost" xmlns="jabber:client" to="user_jqpbkq0027@localhost/993927746-tigase-19" id="ysvo2qcPEkXo7s2tavgMWgC" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" to="user_jqpbkq0027@localhost/993927746-tigase-19" id="wG9CeS0m4z8iTgRW0p2fKKS" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:23 | Disconnecting

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost/993927746-tigase-19 << <presence from="user_jqpbkq0027@localhost/993927746-tigase-19" xmlns="jabber:client" to="user_jqpbkq0027@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:23 | [Mutex] notify: [disconnected]

2019-11-22 20:25:23 | [Mutex] received everything.

2019-11-22 20:25:23 | [Mutex] waiting for: [event]

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1FcnhYa016NHZrNERxNFhYZ1ltbQ==</auth>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FcnhYa016NHZrNERxNFhYZ1ltbTBuWGRoZFFLcHV2YzJIZE8waFpQLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RXJ4WGtNejR2azREcTRYWGdZbW0wblhkaGRRS3B1dmMySGRPMGhaUCxwPVNTVElReEVHendpbmVTUWgwN2RUZXdPUXQ2VVBPL1FhbktRRUp6ZnZyTVk9</response>

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

2019-11-22 20:25:23 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:23 | [Mutex] received everything.

2019-11-22 20:25:23 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:23 | [Mutex] waiting for: [event]

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1kWUxRY1NFcXhrQ05jU1hLU2tsRQ==</auth>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kWUxRY1NFcXhrQ05jU1hLU2tsRTJMRkNKdVllU01lM21kNXlEU2h2LHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZFlMUWNTRXF4a0NOY1NYS1NrbEUyTEZDSnVZZVNNZTNtZDV5RFNodixwPUJCOWVHK283L0Fxd2Ftb0Fyb3ROa0VtdHJxdFkvVXBtbk55aFRLeWZOdDQ9</response>

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

2019-11-22 20:25:23 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:23 | [Mutex] received everything.

2019-11-22 20:25:23 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:23 | [Mutex] waiting for: [event]

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1oUnhFTFRkZzlLanFhMmlOZ1BDbw==</auth>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1oUnhFTFRkZzlLanFhMmlOZ1BDb1Q2Q1poOHJYTHJrN3dnNkV5WUkxLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aFJ4RUxUZGc5S2pxYTJpTmdQQ29UNkNaaDhyWExyazd3ZzZFeVlJMSxwPVQ1TnY2TitxSDhUNFh2WnhyOUdSdUZxNEFURUJFNDdBVmRpZVR3OGxmejA9</response>

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

2019-11-22 20:25:23 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:23 | [Mutex] received everything.

2019-11-22 20:25:23 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:23 | [Mutex] waiting for: [event]

2019-11-22 20:25:23 | user :: user_jqpbkq0027@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-11-22 20:25:23 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1NTDJkb3BjYm9XS2JoWE9qUVpXMQ==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NTDJkb3BjYm9XS2JoWE9qUVpXMU5hV1JHVE1Sa1owT2xvUWFOdXkzLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TUwyZG9wY2JvV0tiaFhPalFaVzFOYVdSR1RNUmtaME9sb1FhTnV5MyxwPVBIZmRlTzdhWXkrWkZFbmhYUlJnRWh6aUo0WWd0KytrRmUxUytCdWtSaEk9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] notify: [event, disconnected]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj12U1RDM3pMZks3eWNnVW1SR3h5Rg==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12U1RDM3pMZks3eWNnVW1SR3h5RjRoNm5DRTdFMGRIMWIzbUJ4dHRCLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dlNUQzN6TGZLN3ljZ1VtUkd4eUY0aDZuQ0U3RTBkSDFiM21CeHR0QixwPVdFM3hzdlZVYUJaa3NJaU9RTjFDUWZBWHoyTzh3OW9SdzBvZ2I1bmZWVm89</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1OUnI5eEowTnlJYTZaQ3pRVG5Hdg==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OUnI5eEowTnlJYTZaQ3pRVG5HdjJBS0s1bG9CdE03ZzVqWHBGd28yLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TlJyOXhKME55SWE2WkN6UVRuR3YyQUtLNWxvQnRNN2c1alhwRndvMixwPVN2eVAwdGMvbGRQb3ZVWlZPbURPMmZMQU9FYTFQSjgxWXVFNko5cmtBeW89</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1lWFA5Qkl6T3U4YWJjcG56QTZWNQ==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lWFA5Qkl6T3U4YWJjcG56QTZWNUtCd2NYUHZ2RXo5aHB6eGpIdlZyLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZVhQOUJJek91OGFiY3BuekE2VjVLQndjWFB2dkV6OWhwenhqSHZWcixwPUY0N2JpT3FNSlhYSHJoRFhXVzJMY25ucWRUcCtEQ3lHbGRXK3NlVUk3VHc9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1mVjIxcVNGM3RjeTh6T1Jpc01mMQ==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1mVjIxcVNGM3RjeTh6T1Jpc01mMW1iSkxzcDlhNXFkT040SEVqRDdvLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZlYyMXFTRjN0Y3k4ek9SaXNNZjFtYkpMc3A5YTVxZE9ONEhFakQ3byxwPXVkbmxUTHpBTHBYVC8yTGJERmF0U2kvbUNJOUtsQUZReXJMcTV0TVlyVkU9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1EN0YxT1E5dktzc3g2WW1RRVBJRg==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1EN0YxT1E5dktzc3g2WW1RRVBJRkVlYWxJRjdSQ3dHM0kzQWdXT09ULHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RDdGMU9ROXZLc3N4NlltUUVQSUZFZWFsSUY3UkN3RzNJM0FnV09PVCxwPUswcmx1Z1NuZjNZSXpnWWtTMlpPNnI1MTYyUVJqMUh3SHc5cERuUEhRSGc9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1UV3Q4ZlRMM3FCc01VbnZRTmExYQ==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1UV3Q4ZlRMM3FCc01VbnZRTmExYWVBT3lzRFRBemFzU0l6dDlpTk5yLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VFd0OGZUTDNxQnNNVW52UU5hMWFlQU95c0RUQXphc1NJenQ5aU5OcixwPVhpeWJIRlJHV0lXS0lOTFNEd1d4eWNudHl4KzRrTzJUYVA5RE1jMHRsL0k9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj03REZjcUJpM0taQmdzc1pmSE1TcQ==</auth>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03REZjcUJpM0taQmdzc1pmSE1TcTV0NnZ3TFdhTnpxM3BLc2ljOVZrLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N0RGY3FCaTNLWkJnc3NaZkhNU3E1dDZ2d0xXYU56cTNwS3NpYzlWayxwPUNsYjVDWUlkNk5PK1dIRFNNdmRXcUVrckR6Nk5lTTVSUUtwOVZUdzlJNUk9</response>

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

2019-11-22 20:25:24 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:24 | [Mutex] received everything.

2019-11-22 20:25:24 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:24 | [Mutex] waiting for: [event]

2019-11-22 20:25:24 | user :: user_jqpbkq0027@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-11-22 20:25:24 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1rTHZ4MnJtdzNNM09HMXhrSnNmbg==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rTHZ4MnJtdzNNM09HMXhrSnNmbkNlR2Fna1lxMFRQOHI1aFE5YlQwLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a0x2eDJybXczTTNPRzF4a0pzZm5DZUdhZ2tZcTBUUDhyNWhROWJUMCxwPU1QUGQ1ZFhDN3VUR3IzeXg4N1VCejFZTjhJMjg0c05UbW5RMHAwS1lsdFk9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1SbWlJN0M0ZXZoTzVkUUl4Z0Nqcw==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SbWlJN0M0ZXZoTzVkUUl4Z0Nqc0gxZWhEZ29vdmNuSWNSUnBWa3RjLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Um1pSTdDNGV2aE81ZFFJeGdDanNIMWVoRGdvb3ZjbkljUlJwVmt0YyxwPVdsSGxQYTdOc1RQREovSGkvaWxCcGRCaFRCRHZsSUNRNFUxQzFtd0ZrdHM9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj0ydHdGU3NKUGdqamo4TXJ6TGNDdQ==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0ydHdGU3NKUGdqamo4TXJ6TGNDdTZybXVNbkFxcnlUeDE3ZUwxb1VnLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MnR3RlNzSlBnampqOE1yekxjQ3U2cm11TW5BcXJ5VHgxN2VMMW9VZyxwPTg0aFdmRmlDeUx5TkN0WFlFa3pBc3ZEaFVMY1NCckNPZHhyeFhoRmhyUVk9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1qZ1F5NVo0am5zNXZxV2Q0UnZDSw==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1qZ1F5NVo0am5zNXZxV2Q0UnZDS2d5Zjg3RjJCOWNQNXlseGg4UklNLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9amdReTVaNGpuczV2cVdkNFJ2Q0tneWY4N0YyQjljUDV5bHhoOFJJTSxwPXYzOW5qazFJUis5UnYxZGtKK21uSlhWNjlGU2l2SzZvZE9YOVFaYzIzZ289</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1TMmg1TXI0NFpGUGtOalQxT09LTg==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1TMmg1TXI0NFpGUGtOalQxT09LTmlDdG1DM3ljUzBPV0hLS0JjMmh3LHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UzJoNU1yNDRaRlBrTmpUMU9PS05pQ3RtQzN5Y1MwT1dIS0tCYzJodyxwPWZVaVp4Q3EvR29KbWpFUnFwVnRRUmhwb3JJV2k0T0h3MFp4YzRqNUc1WUE9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj12SmVjaUlmM1ZBQ1djeHViaDFLSQ==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12SmVjaUlmM1ZBQ1djeHViaDFLSXlvbmQ2Wk9LZko4eUxNcW5MRzJxLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkplY2lJZjNWQUNXY3h1YmgxS0l5b25kNlpPS2ZKOHlMTXFuTEcycSxwPW9WNHBXSENGTk1PK3ZvdjFHVW9vVG12UE92cldDcC9WR00zMm95T29ucU09</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] notify: [event, disconnected]

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1valdNQnd5Smo0VjdmdW1ycE5rSg==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1valdNQnd5Smo0VjdmdW1ycE5rSnprWUhBalVDSUd2dktreGZ6cXlXLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b2pXTUJ3eUpqNFY3ZnVtcnBOa0p6a1lIQWpVQ0lHdnZLa3hmenF5VyxwPTBTUkNUbStLYno2MUlqSHh0bjYxZDFlQm1VYjFMamJ6a1l4eTZIc2swUnc9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1wTUJtRGlkSnFoZkh6bkhQWkc0dg==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1wTUJtRGlkSnFoZkh6bkhQWkc0dk9RVkNuZ0h6SVlKMUFod3RaN0VYLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cE1CbURpZEpxaGZIem5IUFpHNHZPUVZDbmdIeklZSjFBaHd0WjdFWCxwPUVReFFUSUdLSWJGQVkxZHJaTC9LN2oxQzJVYVRDMktrRXJqNE1TMHpmcUU9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1HVmRFWmpFZFRNTGdSelU3Vm5waA==</auth>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1HVmRFWmpFZFRNTGdSelU3Vm5waG1UUTNsWjNEVTVXUG9ZdUxmSXhvLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9R1ZkRVpqRWRUTUxnUnpVN1ZucGhtVFEzbFozRFU1V1BvWXVMZkl4byxwPXovMnNUb2k4TG1aZFVnWmU2TmJCZStPajlwdVpncWEvN0gwVUoxWVBGVms9</response>

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

2019-11-22 20:25:25 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:25 | [Mutex] notify: [event, disconnected]

2019-11-22 20:25:25 | [Mutex] received everything.

2019-11-22 20:25:25 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:25 | [Mutex] waiting for: [event]

2019-11-22 20:25:25 | user :: user_jqpbkq0027@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-11-22 20:25:25 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@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-11-22 20:25:26 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1tSkNreGtWZEVHZFJPUEd4MXpYcA==</auth>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tSkNreGtWZEVHZFJPUEd4MXpYcG1keGZ1YWpiWExmRUZtdjlBSXduLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bUpDa3hrVmRFR2RST1BHeDF6WHBtZHhmdWFqYlhMZkVGbXY5QUl3bixwPWx5dmJhQUt3NTZRcjlEcFJaSU1KOFdwc0NodHVDZVFOTXJxaWJiRTlGTFE9</response>

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

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

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

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

2019-11-22 20:25:26 | user :: user_jqpbkq0027@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-11-22 20:25:26 | user :: user_jqpbkq0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@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-11-22 20:25:26 | user :: user_jqpbkq0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2pxcGJrcTAwMjcscj1hOUljbGt1cGNDRTV0bFp2bHl4UA==</auth>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1hOUljbGt1cGNDRTV0bFp2bHl4UFQyWlhlMmFIb25uNDBaTlFlUmRoLHM9a2ppQUpJd2FBbDY4b2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:26 | user :: user_jqpbkq0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9YTlJY2xrdXBjQ0U1dGxadmx5eFBUMlpYZTJhSG9ubjQwWk5RZVJkaCxwPVJRbXRwZGF5WkV4enNlUHZ1MGw0VG1VYXEzcFJ3ZEkrbXRRTThaQ0dyR289</response>

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

2019-11-22 20:25:28 | [Mutex] waiting for: [user]

2019-11-22 20:25:28 | [Mutex] received everything.

2019-11-22 20:25:28 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.067s
2019-11-22 20:25:28 |

2019-11-22 20:25:28 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 20:25:28 | ------------------------------------

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@25c07613

2019-11-22 20:25:28 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2b078cdb}, 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@2f381d63}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6a3a86e0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c6c055a}, 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=Fri Nov 22 20:25:28 PST 2019}}}}

2019-11-22 20:25:28 | [Mutex] waiting for: [registration]

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@5b9a2958

2019-11-22 20:25:28 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2b078cdb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@2f381d63}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6a3a86e0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c6c055a}, 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=Fri Nov 22 20:25:28 PST 2019}}}}

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3426f44d

2019-11-22 20:25:28 | 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-11-22 20:25:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a1579af}

2019-11-22 20:25:28 | 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-11-22 20:25:28 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@26ffeb62

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2ca5c60c

2019-11-22 20:25:28 | 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-11-22 20:25:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2f22db49}

2019-11-22 20:25:28 | 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-11-22 20:25:28 | user :: null >> <iq to="localhost" id="ywzwiWeTMAtqbAiZczo2siG" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 20:25:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@210b08a}

2019-11-22 20:25:28 | user :: null << <iq from="localhost" xmlns="jabber:client" id="ywzwiWeTMAtqbAiZczo2siG" type="result"><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-11-22 20:25:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@e5b0703}

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@57a64951

2019-11-22 20:25:28 | user :: null >> <iq to="localhost" id="wKdKuo2qcPEkXo7s2tavgMW" type="set"><query xmlns="jabber:iq:register"><username>user_r4gv0028</username><password>user_r4gv0028</password><email>0bd98b88-0443-4294-b95d-12408b66c19f@localhost</email></query></iq>

2019-11-22 20:25:28 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@28133351}

2019-11-22 20:25:28 | user :: null << <iq from="localhost" xmlns="jabber:client" id="wKdKuo2qcPEkXo7s2tavgMW" type="result"/>

2019-11-22 20:25:28 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5531600f}

2019-11-22 20:25:28 | [Mutex] received everything.

2019-11-22 20:25:28 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 20:25:28 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a1579af, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2f22db49]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2b078cdb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@2f381d63}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6a3a86e0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c6c055a}, 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=Fri Nov 22 20:25:28 PST 2019}}}}

2019-11-22 20:25:28 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@a1579af, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@2f22db49]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@2b078cdb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@2f381d63}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@6a3a86e0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@4c6c055a}, 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=Fri Nov 22 20:25:28 PST 2019}}}}

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6cf01173

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@3ac570f1

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5fcc4a39

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1a368d7

2019-11-22 20:25:28 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@6db49a19

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9QUc0MFJuUnA1ZWxjcGZBWHdpRlY=</auth>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BRzQwUm5ScDVlbGNwZkFYd2lGVlVHT1NpR21CRzlqSWo2a3pqMEJjLHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QUc0MFJuUnA1ZWxjcGZBWHdpRlZVR09TaUdtQkc5aklqNmt6ajBCYyxwPStqbnFQbmpOdnpWZ2U2MjlCOEtMR2ExdkdydDhiU3JjSzd2NFJrT2FCN1E9</response>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj10MGJxNnRnRkVDcm5mRzRWNExkNDhpNXF0NENUakpxNmV5WlphamhZWm80PQ==</success>

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

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <iq xmlns="jabber:client" id="RWLADyAyreSbPR48GCAwtWU" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost << <iq xmlns="jabber:client" to="user_r4gv0028@localhost/993927746-tigase-20" id="RWLADyAyreSbPR48GCAwtWU" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_r4gv0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="4Po6yx4aDKPSS9wdGCCCk7w" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_r4gv0028@localhost/993927746-tigase-20" id="4Po6yx4aDKPSS9wdGCCCk7w" type="result"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="aTyyr6k3kPU4wqWlYqeNWi1" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 << <enabled max="60" xmlns="urn:xmpp:sm:3" resume="true" id="e5ce0cd5-1687-48e9-9e29-2f93e506a6a7" location="d4270859fb27"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 >> <iq id="0OhSKU4uk5am1wnY4xiLMO0" type="get"><query xmlns="jabber:iq:roster"/></iq>

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

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 << <iq from="localhost" xmlns="jabber:client" to="user_r4gv0028@localhost/993927746-tigase-20" id="aTyyr6k3kPU4wqWlYqeNWi1" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" to="user_r4gv0028@localhost/993927746-tigase-20" id="0OhSKU4uk5am1wnY4xiLMO0" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:28 | Disconnecting

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

2019-11-22 20:25:28 | [Mutex] notify: [disconnected]

2019-11-22 20:25:28 | [Mutex] received everything.

2019-11-22 20:25:28 | [Mutex] waiting for: [event]

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9bVBjZGJFVzJMcXNsdkhpc1l3dm0=</auth>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tUGNkYkVXMkxxc2x2SGlzWXd2bTM4WFp2aFlHVXR2UVpJSDFxRjV5LHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bVBjZGJFVzJMcXNsdkhpc1l3dm0zOFhadmhZR1V0dlFaSUgxcUY1eSxwPTB1aHk4QkRxYmZzbFN3NTQyaW1yTDdxNjV5UTNFMFlERGp0Szg5S1lwcFU9</response>

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

2019-11-22 20:25:28 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:28 | [Mutex] received everything.

2019-11-22 20:25:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:28 | [Mutex] waiting for: [event]

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9Nm9reGlIZWZLa1ZYaXY3UXhFSGk=</auth>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj02b2t4aUhlZktrVlhpdjdReEVIaTFhTVZhUEE5eWd5dFBNRGd1d0NwLHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:28 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Nm9reGlIZWZLa1ZYaXY3UXhFSGkxYU1WYVBBOXlneXRQTURndXdDcCxwPVp2VVZYcWxmRUVMU2k3WmNIcEYwbkZ0WndvbjFtUlZFOUE1eVlWV3UxWUE9</response>

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

2019-11-22 20:25:28 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:28 | [Mutex] received everything.

2019-11-22 20:25:28 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:28 | [Mutex] waiting for: [event]

2019-11-22 20:25:28 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:29 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9c2NkMmRiYU9YZ3dISlZiTlFzR1U=</auth>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zY2QyZGJhT1hnd0hKVmJOUXNHVUVXbERkUDY0UnVHN1NNRTFnN3FHLHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2NkMmRiYU9YZ3dISlZiTlFzR1VFV2xEZFA2NFJ1RzdTTUUxZzdxRyxwPUJYYi9Jcm9zbHBFTHBCZ3NhMjNUWkhMRHpNV3d2anBoWkF2QzQ5eklrMXc9</response>

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

2019-11-22 20:25:29 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:29 | [Mutex] received everything.

2019-11-22 20:25:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:29 | [Mutex] waiting for: [event]

2019-11-22 20:25:29 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:29 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9a1MySGl4R2lDSjFCME5WMUFsT2o=</auth>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rUzJIaXhHaUNKMUIwTlYxQWxPanlmWXB3czZ1MUc0c3RUU1V6VHNRLHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9a1MySGl4R2lDSjFCME5WMUFsT2p5Zllwd3M2dTFHNHN0VFNVelRzUSxwPUYrYkhmbVNCYUJYSk1aY2FBNVZHY0NKLy82TDBzSk5kbFZ6U3VOcVVvR1U9</response>

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

2019-11-22 20:25:29 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:29 | [Mutex] received everything.

2019-11-22 20:25:29 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:29 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:29 | user :: user_r4gv0028@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-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3I0Z3YwMDI4LHI9b0V0S1hudjVBZjk2Zmpid2N3b20=</auth>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vRXRLWG52NUFmOTZmamJ3Y3dvbWwxaFpqc1FWWFZHTDFCeFV3dUx3LHM9YTdYMUowbjgvM3JQYlE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:29 | user :: user_r4gv0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b0V0S1hudjVBZjk2Zmpid2N3b21sMWhaanNRVlhWR0wxQnhVd3VMdyxwPWg0ZjRhZndVMEw5M0ZUTnRqQmNncFlMOFFIVUtIRGFGaHBVUHNQVVlHeUU9</response>

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

2019-11-22 20:25:31 | [Mutex] waiting for: [user]

2019-11-22 20:25:31 | [Mutex] received everything.

2019-11-22 20:25:31 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.079s
2019-11-22 20:25:31 |

2019-11-22 20:25:31 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 20:25:31 | ------------------------------------

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@63321c3e

2019-11-22 20:25:31 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df5ee28}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@69ca774e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cc8e413}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fe8ce58}, 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=Fri Nov 22 20:25:31 PST 2019}}}}

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@1d2eef23

2019-11-22 20:25:31 | [Mutex] waiting for: [registration]

2019-11-22 20:25:31 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df5ee28}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@69ca774e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cc8e413}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fe8ce58}, 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=Fri Nov 22 20:25:31 PST 2019}}}}

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@27e49bcf

2019-11-22 20:25: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-11-22 20:25:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce71b5c}

2019-11-22 20:25: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-11-22 20:25:31 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@55648696

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@3f592cee

2019-11-22 20:25: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-11-22 20:25:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ce0f229}

2019-11-22 20:25: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-11-22 20:25:31 | user :: null >> <iq to="localhost" id="f3U0bCum6i3ogU9EIRbzuYm" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 20:25:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@c58f4bca}

2019-11-22 20:25:31 | user :: null << <iq from="localhost" xmlns="jabber:client" id="f3U0bCum6i3ogU9EIRbzuYm" type="result"><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-11-22 20:25:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@48a92312}

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@39885ca7

2019-11-22 20:25:31 | user :: null >> <iq to="localhost" id="I0JEqfIBsaIOIT4CCzuodTZ" type="set"><query xmlns="jabber:iq:register"><username>user_9kppcf0029</username><password>user_9kppcf0029</password><email>39cc1296-c3c8-404d-bad7-9aa44e9e8c98@localhost</email></query></iq>

2019-11-22 20:25:31 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@cc247994}

2019-11-22 20:25:31 | user :: null << <iq from="localhost" xmlns="jabber:client" id="I0JEqfIBsaIOIT4CCzuodTZ" type="result"/>

2019-11-22 20:25:31 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4f402924}

2019-11-22 20:25:31 | [Mutex] received everything.

2019-11-22 20:25:31 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 20:25:31 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce71b5c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ce0f229]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df5ee28}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@69ca774e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cc8e413}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fe8ce58}, 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=Fri Nov 22 20:25:31 PST 2019}}}}

2019-11-22 20:25:31 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4ce71b5c, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@3ce0f229]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@6df5ee28}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@69ca774e}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@2cc8e413}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@5fe8ce58}, 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=Fri Nov 22 20:25:31 PST 2019}}}}

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@748aeb5f

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@75baf76f

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@e2cf01b

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@406be1f3

2019-11-22 20:25:31 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@63183ab2

2019-11-22 20:25:31 | user :: user_9kppcf0029@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-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:31 | user :: user_9kppcf0029@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-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlrcHBjZjAwMjkscj1pZjJkWlQwQ1k5T2dvYkVXRkx3cA==</auth>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1pZjJkWlQwQ1k5T2dvYkVXRkx3cDE4RDJUWkVPQnR0NklGdGN3ZkNrLHM9R0VLSXRjb2d0MDFMZUE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9aWYyZFpUMENZOU9nb2JFV0ZMd3AxOEQyVFpFT0J0dDZJRnRjd2ZDayxwPTZybjBTNmdNSTFQTEdqRzRkSXUrMUNYbC9XYmcwbkNaR1pBZEFWZitxdlE9</response>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1MY1kra0p5Q3B5aDRuTWw2aTNGSzRDUzNZTFFhL2NwdUQ1eXRkSGU1THgwPQ==</success>

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

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <iq xmlns="jabber:client" id="u72vdMywiWeTMAtqbAiZczo" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost << <iq xmlns="jabber:client" to="user_9kppcf0029@localhost/993927746-tigase-21" id="u72vdMywiWeTMAtqbAiZczo" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_9kppcf0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="PXwoaqjUiYhUeTfHKuo2qcP" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_9kppcf0029@localhost/993927746-tigase-21" id="PXwoaqjUiYhUeTfHKuo2qcP" type="result"/>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="c3MKCDu9ym6AgZg0o7AABFx" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 << <enabled max="60" xmlns="urn:xmpp:sm:3" resume="true" id="c4c9f7c0-347b-4076-986c-f95901af1b8f" location="d4270859fb27"/>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 >> <iq id="15QEIGIMZYYfYhMGLKFAqeQ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 << <iq from="localhost" xmlns="jabber:client" to="user_9kppcf0029@localhost/993927746-tigase-21" id="c3MKCDu9ym6AgZg0o7AABFx" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" to="user_9kppcf0029@localhost/993927746-tigase-21" id="15QEIGIMZYYfYhMGLKFAqeQ" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:31 | Disconnecting

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost/993927746-tigase-21 << <presence from="user_9kppcf0029@localhost/993927746-tigase-21" xmlns="jabber:client" to="user_9kppcf0029@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:31 | [Mutex] notify: [disconnected]

2019-11-22 20:25:31 | [Mutex] received everything.

2019-11-22 20:25:31 | [Mutex] waiting for: [event]

2019-11-22 20:25:31 | user :: user_9kppcf0029@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-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:31 | user :: user_9kppcf0029@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-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlrcHBjZjAwMjkscj1tOU1VeHJ0SU40SVNFUWJoc2VHbA==</auth>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1tOU1VeHJ0SU40SVNFUWJoc2VHbGdveHhsZjB1UVBTUTd5YTIzRk55LHM9R0VLSXRjb2d0MDFMZUE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bTlNVXhydElONElTRVFiaHNlR2xnb3h4bGYwdVFQU1E3eWEyM0ZOeSxwPWhKWUJ3SnZuS2ErSFRNa09SN1BoUU9nTkNuc3ZPWnRyTWRncG9qVy9HNUk9</response>

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

2019-11-22 20:25:31 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:31 | [Mutex] received everything.

2019-11-22 20:25:31 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:31 | [Mutex] waiting for: [event]

2019-11-22 20:25:31 | user :: user_9kppcf0029@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-11-22 20:25:31 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfOWtwcGNmMDAyOQAgLSAtIC0gLSAt</auth>

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

2019-11-22 20:25:32 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:32 | [Mutex] received everything.

2019-11-22 20:25:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:32 | [Mutex] waiting for: [event]

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyXzlrcHBjZjAwMjkscj12QW9mTWY2dlVYZHhONE1nUWd0aA==</auth>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12QW9mTWY2dlVYZHhONE1nUWd0aFFhSEpyUjBQMlRKelFRdUN1U1Y1LHM9amNMZW1sWlN6SUpZY2c9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dkFvZk1mNnZVWGR4TjRNZ1FndGhRYUhKclIwUDJUSnpRUXVDdVNWNSxwPUJ1RFdGTDNCNTEvUENxbUNGNHFCV3NLV2JRUT0=</response>

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

2019-11-22 20:25:32 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:32 | [Mutex] received everything.

2019-11-22 20:25:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:32 | [Mutex] waiting for: [event]

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlrcHBjZjAwMjkscj1vNzloVXlWcGd3UjdBQkNnYm9PcA==</auth>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vNzloVXlWcGd3UjdBQkNnYm9PcHdnSklhMGtUNFVMRFRaYmp6blJKLHM9R0VLSXRjb2d0MDFMZUE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bzc5aFV5VnBnd1I3QUJDZ2JvT3B3Z0pJYTBrVDRVTERUWmJqem5SSixwPXdTWjRlMVAxNEZBcFR1QVpPRTk1RXdDZC9xNGNrV1M3Mnl2eVNsRFdYN009</response>

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

2019-11-22 20:25:32 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:32 | [Mutex] received everything.

2019-11-22 20:25:32 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:32 | user :: user_9kppcf0029@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-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzlrcHBjZjAwMjkscj1BV2IxMGZLOEZPN0RERllsbkxXYw==</auth>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BV2IxMGZLOEZPN0RERllsbkxXY3RmRGVmek5vMVZ1QXE2OUx5RXY0LHM9R0VLSXRjb2d0MDFMZUE9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:32 | user :: user_9kppcf0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QVdiMTBmSzhGTzdEREZZbG5MV2N0ZkRlZnpObzFWdUFxNjlMeUV2NCxwPWlqZER4eWVFR0lxSVFWT2h2SzdYY0YzN0E5dHVZTDZpeTNYMGxoWHBwYXc9</response>

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

2019-11-22 20:25:34 | [Mutex] waiting for: [user]

2019-11-22 20:25:34 | [Mutex] received everything.

2019-11-22 20:25:34 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.174s
2019-11-22 20:25:34 |

2019-11-22 20:25:34 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-22 20:25:34 | ------------------------------------

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@5f1ace04

2019-11-22 20:25:34 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@51dd3b97}, 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@55e2a574}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@10e031ac}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1903a75a}, 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=Fri Nov 22 20:25:34 PST 2019}}}}

2019-11-22 20:25:34 | [Mutex] waiting for: [registration]

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@213a266e

2019-11-22 20:25:34 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@51dd3b97}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@55e2a574}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@10e031ac}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1903a75a}, 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=Fri Nov 22 20:25:34 PST 2019}}}}

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@6133ee38

2019-11-22 20:25:34 | 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-11-22 20:25:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70cfcee3}

2019-11-22 20:25:34 | 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-11-22 20:25:34 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@74f28ed7

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@40bdf71

2019-11-22 20:25:34 | 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-11-22 20:25:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a37a3e6}

2019-11-22 20:25:34 | 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-11-22 20:25:34 | user :: null >> <iq to="localhost" id="9OV7ILKCDu9ym6AgZg0o7AA" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-22 20:25:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@ea3476af}

2019-11-22 20:25:34 | user :: null << <iq from="localhost" xmlns="jabber:client" id="9OV7ILKCDu9ym6AgZg0o7AA" type="result"><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-11-22 20:25:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7481d295}

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@14e57ee4

2019-11-22 20:25:34 | user :: null >> <iq to="localhost" id="zd6qcKVQIJWdEqfIBsaIOIT" type="set"><query xmlns="jabber:iq:register"><username>user_puzo3p0030</username><password>user_puzo3p0030</password><email>0f0d4112-ad50-486f-a04f-620b4cf5c6ab@localhost</email></query></iq>

2019-11-22 20:25:34 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@94611781}

2019-11-22 20:25:34 | user :: null << <iq from="localhost" xmlns="jabber:client" id="zd6qcKVQIJWdEqfIBsaIOIT" type="result"/>

2019-11-22 20:25:34 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@4ecfdb5e}

2019-11-22 20:25:34 | [Mutex] received everything.

2019-11-22 20:25:34 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-22 20:25:34 | StateChangedEvent{oldState=connected, newState=disconnecting, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70cfcee3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a37a3e6]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@51dd3b97}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@55e2a574}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@10e031ac}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1903a75a}, 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=Fri Nov 22 20:25:34 PST 2019}}}}

2019-11-22 20:25:34 | StateChangedEvent{oldState=disconnecting, newState=disconnected, sessionObject=AbstractSessionObject{properties={CONNECTOR#ENCRYPTED_KEY=Entry{scope=stream, value=true}, TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@fc2d2ba}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@70cfcee3, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7a37a3e6]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@51dd3b97}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@4effd881}, 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@55e2a574}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@10e031ac}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@1903a75a}, 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=Fri Nov 22 20:25:34 PST 2019}}}}

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@9a079f2

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@734f0729

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@4c6245fa

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7cc77203

2019-11-22 20:25:34 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7622eb80

2019-11-22 20:25:34 | user :: user_puzo3p0030@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-11-22 20:25:34 | user :: user_puzo3p0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:34 | user :: user_puzo3p0030@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-11-22 20:25:34 | user :: user_puzo3p0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3B1em8zcDAwMzAscj1FTVVEVXNjd1p3WlVTY05nSjJ6SA==</auth>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FTVVEVXNjd1p3WlVTY05nSjJ6SFd5blhiYmJUMjdmTGFTSGlVV25ELHM9YUwvZTViak1jYStLMnc9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RU1VRFVzY3dad1pVU2NOZ0oyekhXeW5YYmJiVDI3ZkxhU0hpVVduRCxwPSs5YU00bFBEWmlrVkpodTFRMmgwQmZ5eWJkbzMyRndGcHZiWkxOQndIQk09</response>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0wa29HdjFCYjdFWXJHRWRWTWtmTHFpM21uNzRYSFMwZTJkYXgvKzNpUTMwPQ==</success>

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

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost >> <iq xmlns="jabber:client" id="qc1l2uphLSKU4uk5am1wnY4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-22" id="qc1l2uphLSKU4uk5am1wnY4" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_puzo3p0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="U7KWgR4yxxhUO2k0m9iCxyr" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-22" id="U7KWgR4yxxhUO2k0m9iCxyr" type="result"/>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="6cXjCgP8BqYlUZeIO06FCIO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 << <enabled max="60" xmlns="urn:xmpp:sm:3" resume="true" id="f053ba79-6e47-407a-8c9a-832ea631797b" location="d4270859fb27"/>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 >> <iq id="g5AjS0oaqjUiYhUeTfHKuo2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 << <iq from="localhost" xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-22" id="6cXjCgP8BqYlUZeIO06FCIO" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-22" id="g5AjS0oaqjUiYhUeTfHKuo2" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:34 | Disconnecting

2019-11-22 20:25:34 | user :: user_puzo3p0030@localhost/993927746-tigase-22 << <presence from="user_puzo3p0030@localhost/993927746-tigase-22" xmlns="jabber:client" to="user_puzo3p0030@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:34 | [Mutex] notify: [disconnected]

2019-11-22 20:25:34 | [Mutex] received everything.

2019-11-22 20:25:34 | [Mutex] waiting for: [event]

2019-11-22 20:25:34 | user :: user_puzo3p0030@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-11-22 20:25:34 | user :: user_puzo3p0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3B1em8zcDAwMzAscj0wcktOREllbnZ0QXBNVmNQdHFxZQ==</auth>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0wcktOREllbnZ0QXBNVmNQdHFxZUdYZUpWd2M2M3Azdzl0VXVNaGNWLHM9YUwvZTViak1jYStLMnc9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MHJLTkRJZW52dEFwTVZjUHRxcWVHWGVKVndjNjNwM3c5dFV1TWhjVixwPS9TV1NqaUVTZlR2bzJNWU0xaUJMRHpkVjFLRkRUcDQvMVdvMGZydmtTWjA9</response>

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

2019-11-22 20:25:35 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:35 | [Mutex] received everything.

2019-11-22 20:25:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:35 | [Mutex] waiting for: [event]

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3B1em8zcDAwMzAscj1Mb1FzUTM2MlBBMlFldE9Yc2hyTw==</auth>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1Mb1FzUTM2MlBBMlFldE9Yc2hyT2owS1dxWUVwdTl6Qkh1QVh3SWpjLHM9YUwvZTViak1jYStLMnc9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TG9Rc1EzNjJQQTJRZXRPWHNock9qMEtXcVlFcHU5ekJIdUFYd0lqYyxwPWNBVEJVNXZScjRlclEraElhRW1nSWpBT1d2N29ET1dJVWwxcW1HanhOY0E9</response>

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

2019-11-22 20:25:35 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:35 | [Mutex] received everything.

2019-11-22 20:25:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:35 | [Mutex] waiting for: [event]

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3B1em8zcDAwMzAscj15cFVieWV5Unk2eVdVc0cwZHJHVw==</auth>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj15cFVieWV5Unk2eVdVc0cwZHJHV0RTbjBPWEttUWEzZmpsRFFQeWk2LHM9YUwvZTViak1jYStLMnc9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9eXBVYnlleVJ5NnlXVXNHMGRyR1dEU24wT1hLbVFhM2ZqbERRUHlpNixwPW5LVlQ4VmVUbVRUYWwrQU5GYUYvTUVYd2pLZjJVQ2RzMkpZbTBsT3J4bGM9</response>

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

2019-11-22 20:25:35 | [Mutex] notify: [event, authFailed]

2019-11-22 20:25:35 | [Mutex] received everything.

2019-11-22 20:25:35 | [Mutex] isItemNotified: authFailed :: true

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@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-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3B1em8zcDAwMzAscj1CR3hlOTRpallJU2dvUVJxRXBBYw==</auth>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1CR3hlOTRpallJU2dvUVJxRXBBY2U1ZmVSUndWcXZpZU9QWEJTMjg2LHM9YUwvZTViak1jYStLMnc9PSxpPTQwOTY=</challenge>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Qkd4ZTk0aWpZSVNnb1FScUVwQWNlNWZlUlJ3VnF2aWVPUFhCUzI4NixwPU13S3pFNjF1TXhOOEVmTlVOSVIvSmFOMXZzdjA5Z1BxQ3ZQdVAvei9UcTQ9</response>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj0zMDA0WWNvZndaQVBGMDhuZXRCMVhJVU5CSGRNTVFqaUpVY3c1ODliUURBPQ==</success>

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

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost >> <iq xmlns="jabber:client" id="kg5w8JKYkZk4zBpak4o8CFk" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-23" id="kg5w8JKYkZk4zBpak4o8CFk" type="result"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_puzo3p0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="nmlWm6xqgXnXgwsaGIRIsdU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-23" id="nmlWm6xqgXnXgwsaGIRIsdU" type="result"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="ki7AgZg0o7AABFxqQ6sgSbm" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 << <enabled max="60" xmlns="urn:xmpp:sm:3" resume="true" id="3b73ba08-a96d-4061-8c05-e1b7d0afabd5" location="d4270859fb27"/>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 >> <iq id="xh22ueOYnKwlaFyeRW3mYk2" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 >> <presence><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 << <iq from="localhost" xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-23" id="ki7AgZg0o7AABFxqQ6sgSbm" type="result"><query xmlns="http://jabber.org/protocol/disco#info"><identity category="component" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="router"/><identity category="server" name="Tigase ver. 8.1.0-SNAPSHOT-b10588/f55efd39" type="im"/><feature var="http://jabber.org/protocol/commands"/><x xmlns="jabber:x:data" type="result"><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="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push:ignore-unknown:0"/><feature var="tigase:push:muc:0"/><feature var="tigase:push:priority:0"/><feature var="tigase:push:muted:0"/><feature var="jabber:iq:roster"/><feature var="jabber:iq:roster-dynamic"/><feature var="urn:xmpp:mam:1"/><feature var="jabber:iq:version"/><feature var="urn:xmpp:time"/><feature var="jabber:iq:privacy"/><feature var="urn:ietf:params:xml:ns:xmpp-bind"/><feature var="http://jabber.org/protocol/commands"/><feature var="urn:ietf:params:xml:ns:vcard-4.0"/><feature var="urn:ietf:params:xml:ns:xmpp-session"/><feature var="jabber:iq:private"/></query></iq>

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" to="user_puzo3p0030@localhost/993927746-tigase-23" id="xh22ueOYnKwlaFyeRW3mYk2" type="result"><query xmlns="jabber:iq:roster"/></iq>

2019-11-22 20:25:35 | Disconnecting

2019-11-22 20:25:35 | user :: user_puzo3p0030@localhost/993927746-tigase-23 << <presence from="user_puzo3p0030@localhost/993927746-tigase-23" xmlns="jabber:client" to="user_puzo3p0030@localhost"><c xmlns="http://jabber.org/protocol/caps" node="http://tigase.org/jaxmpp" ver="mg5bXbOeu1848vxdgu3jELgbQF8=" hash="sha-1"/></presence>

2019-11-22 20:25:35 | [Mutex] notify: [disconnected]

2019-11-22 20:25:35 | [Mutex] received everything.

2019-11-22 20:25:37 | [Mutex] waiting for: [user]

2019-11-22 20:25:37 | [Mutex] received everything.

2019-11-22 20:25:37 | [Mutex] isItemNotified: user:ok:true :: true