Brute Force Prevention

Test duration: 15.327s

Passed Tests
tigase.tests.server.TestBruteforcePrevention
testDisableUser 5.393s
2019-11-27 21:18:48 |

2019-11-27 21:18:48 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 21:18:48 | ------------------------------------

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@289777a9

2019-11-27 21:18:48 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26508ccb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@226f1cd9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@676d86f0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@74d48f8b}, 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=Wed Nov 27 21:18:48 PST 2019}}}}

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@56c0630e

2019-11-27 21:18:48 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26508ccb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@226f1cd9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@676d86f0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@74d48f8b}, 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=Wed Nov 27 21:18:48 PST 2019}}}}

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@c9334db

2019-11-27 21:18:48 | [Mutex] waiting for: [registration]

2019-11-27 21:18:48 | 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-27 21:18:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74279bf}

2019-11-27 21:18:48 | 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-27 21:18:48 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@573a060b

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@2b7d7f1

2019-11-27 21:18:48 | 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-27 21:18:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17971e90}

2019-11-27 21:18:48 | 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-27 21:18:48 | user :: null >> <iq to="localhost" id="ERQX7woNZ4qcMMTWSLWgBzr" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 21:18:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@5eb664d9}

2019-11-27 21:18:48 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="ERQX7woNZ4qcMMTWSLWgBzr"><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-27 21:18:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@30c025c}

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@4014668

2019-11-27 21:18:48 | user :: null >> <iq to="localhost" id="4AZ3wtp7raGn9o4umWdAal6" type="set"><query xmlns="jabber:iq:register"><username>user_aikxqx0027</username><password>user_aikxqx0027</password><email>d0b426c1-2192-4850-970c-771d5b08b776@localhost</email></query></iq>

2019-11-27 21:18:48 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@50a0c071}

2019-11-27 21:18:48 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="4AZ3wtp7raGn9o4umWdAal6"/>

2019-11-27 21:18:48 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@38350146}

2019-11-27 21:18:48 | [Mutex] received everything.

2019-11-27 21:18:48 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 21:18:48 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74279bf, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17971e90]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26508ccb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@226f1cd9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@676d86f0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@74d48f8b}, 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=Wed Nov 27 21:18:48 PST 2019}}}}

2019-11-27 21:18:48 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@74279bf, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@17971e90]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@26508ccb}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@226f1cd9}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@676d86f0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@74d48f8b}, 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=Wed Nov 27 21:18:48 PST 2019}}}}

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@1779eb4e

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@7484051f

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@7a383fe1

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6a172ed1

2019-11-27 21:18:48 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@326c8b46

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1ubVRYdG9nZ0ZHYnNCam92OFpNNA==</auth>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ubVRYdG9nZ0ZHYnNCam92OFpNNE5nTjVvVUxrYWZRT1ZpUWRZR25wLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bm1UWHRvZ2dGR2JzQmpvdjhaTTROZ041b1VMa2FmUU9WaVFkWUducCxwPXNqd1NyV3ZlZVNvSUF5MkFJT0pucjh2dVFrbjgxWFFEK1N5ZFRSeXczYzg9</response>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1KVWZLaUpTYmVBSXJkSHZMbjE5Y1JnQmFnYzNJaFFHdWpxQzVibk1mWCtRPQ==</success>

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

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost >> <iq xmlns="jabber:client" id="LwLMUcCziAbMWXhR6fYXo2b" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <iq xmlns="jabber:client" type="result" id="LwLMUcCziAbMWXhR6fYXo2b" to="user_aikxqx0027@localhost/993927746-tigase-19"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_aikxqx0027@localhost/993927746-tigase-19</jid></bind></iq>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 >> <iq xmlns="jabber:client" id="JsxrYeO0eNKuZoapbFItqRc" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" type="result" id="JsxrYeO0eNKuZoapbFItqRc" to="user_aikxqx0027@localhost/993927746-tigase-19"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 >> <iq to="localhost" id="LyNQ2s8BmIriY1p7Ch25Eyd" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 << <enabled resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" id="a3191feb-a287-474d-8e4b-8d8613c86675"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 >> <iq id="Stw1siFHHMBGneIxfBCFNTZ" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 << <iq from="localhost" xmlns="jabber:client" type="result" id="LyNQ2s8BmIriY1p7Ch25Eyd" to="user_aikxqx0027@localhost/993927746-tigase-19"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 << <iq xmlns="jabber:client" type="result" id="Stw1siFHHMBGneIxfBCFNTZ" to="user_aikxqx0027@localhost/993927746-tigase-19"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:48 | Disconnecting

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost/993927746-tigase-19 << <presence from="user_aikxqx0027@localhost/993927746-tigase-19" xmlns="jabber:client" to="user_aikxqx0027@localhost"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2019-11-27 21:18:48 | [Mutex] notify: [disconnected]

2019-11-27 21:18:48 | [Mutex] received everything.

2019-11-27 21:18:48 | [Mutex] waiting for: [event]

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1jS1JyY3RZckVBbFhnbGxNcVU5bA==</auth>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1jS1JyY3RZckVBbFhnbGxNcVU5bG5QcVUzbllVd0dCS3ByMlREQ25vLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Y0tScmN0WXJFQWxYZ2xsTXFVOWxuUHFVM25ZVXdHQktwcjJURENubyxwPUJpZmYzcjVnaGEwSkJnY3o2d0VkRnFrejJsNmsxNUFacndoeEVOeTlnVnM9</response>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:48 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:48 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:48 | [Mutex] received everything.

2019-11-27 21:18:48 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:48 | [Mutex] waiting for: [event]

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1SbTRidkUyQW41dm1Ndk5QWGVVRg==</auth>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SbTRidkUyQW41dm1Ndk5QWGVVRlVpdFc2bDRNSjVObWduTHZ6SW5SLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Um00YnZFMkFuNXZtTXZOUFhlVUZVaXRXNmw0TUo1Tm1nbkx2ekluUixwPTROM2tHSG1xbDBqbEhSa2I5eWg2azF3WUd3RU82TFN2S3YzcjNEaE5DZ009</response>

2019-11-27 21:18:48 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:48 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:48 | [Mutex] received everything.

2019-11-27 21:18:48 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:48 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:48 | [Mutex] waiting for: [event]

2019-11-27 21:18:48 | user :: user_aikxqx0027@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-27 21:18:48 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1ZNDIwN0xNRFViODJlblRQOEJsbg==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1ZNDIwN0xNRFViODJlblRQOEJsbktpakc1c1ZiOUw2dWRSWmRXa1RDLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WTQyMDdMTURVYjgyZW5UUDhCbG5LaWpHNXNWYjlMNnVkUlpkV2tUQyxwPU9MZUxhZllrUHJkcFk3dkVwdTZaYmxlRUh0MzhYZVJCVHEyemp5cmlsZ2c9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1PR1M1cEg3NlRSU3ZnUUJHd1A2aA==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1PR1M1cEg3NlRSU3ZnUUJHd1A2aG1PYmk2QmhnWDBGWGVXVkRDMUR6LHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9T0dTNXBINzZUUlN2Z1FCR3dQNmhtT2JpNkJoZ1gwRlhlV1ZEQzFEeixwPXVCSW5Rckp5dU1vTktxcUs4dGNBaDUwN1AxSFJraXJZLzB2VjJ4NFNBSkk9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj03TjBER1BoTGpCV3JiaGJpbzJGQQ==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03TjBER1BoTGpCV3JiaGJpbzJGQU5GNWRDRjVkaUk5dGtKV0dTRVNiLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N04wREdQaExqQldyYmhiaW8yRkFORjVkQ0Y1ZGlJOXRrSldHU0VTYixwPXNZdnR0N3ZWaGJvRkVJcG4rRzRDQ3dZL3RpT3o4dTZscU5FblBvRTVaZnM9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1MZmIzcGs5YlpHd085TGtIdDlPeg==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1MZmIzcGs5YlpHd085TGtIdDlPemVoem1jclBla2FsVG5ZNkxGc2pBLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TGZiM3BrOWJaR3dPOUxrSHQ5T3plaHptY3JQZWthbFRuWTZMRnNqQSxwPU5EVEpBY1pFdWFEejE2N2JpK0s4aSs1bjdlN3Rpa3dOMUtGS0pWV3dYeUU9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1NUTdoV1AzWUM2NFl4VTExV1VJVg==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1NUTdoV1AzWUM2NFl4VTExV1VJVmZTTEtPZVFvZFRIQ0tla1dXdWNELHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TVE3aFdQM1lDNjRZeFUxMVdVSVZmU0xLT2VRb2RUSENLZWtXV3VjRCxwPUcySXl2VGE1QzNZT2lrYkdjeDBSLzl5VUNrcUdLMDcwTmpyK1Flay9xSTg9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj0zQ0tKUHVYbkgxMnNVQ2EwZnA1cg==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zQ0tKUHVYbkgxMnNVQ2EwZnA1cmhrS0xOMkFQUGpJSVVGeFRnZTllLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M0NLSlB1WG5IMTJzVUNhMGZwNXJoa0tMTjJBUFBqSUlVRnhUZ2U5ZSxwPUpweTgvM2kyaGdsUnIxSSsyclRLNnEyZ05Pc0lTRlg5NkNsV2tuUTkxdnM9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj00aDNVN1piTFVqNzZoN1IxdzBRSA==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj00aDNVN1piTFVqNzZoN1IxdzBRSGJNREhiczFBMkxhUWNOc21udEFCLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9NGgzVTdaYkxVajc2aDdSMXcwUUhiTURIYnMxQTJMYVFjTnNtbnRBQixwPTdPWTdCVVFJNG9QSTBZVUxKRjluWFhVUUF6bmtqcFZOYkpib3RBNGNIdU09</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj11TEllSzJMa25DVDlneVh0OWo2cg==</auth>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj11TEllSzJMa25DVDlneVh0OWo2clhHdXEyRjhzTzIxWnNUVlROTkExLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dUxJZUsyTGtuQ1Q5Z3lYdDlqNnJYR3VxMkY4c08yMVpzVFZUTk5BMSxwPTZYU2R3b2JTaklUOTZuRjBpbmZGRWRjNWFCTkJCcDFlSUlKalhoV0tIQVU9</response>

2019-11-27 21:18:49 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:49 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:49 | [Mutex] received everything.

2019-11-27 21:18:49 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:49 | [Mutex] waiting for: [event]

2019-11-27 21:18:49 | user :: user_aikxqx0027@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-27 21:18:49 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1kcFUyanJuSVR6ak5wNjFNVDZQVQ==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kcFUyanJuSVR6ak5wNjFNVDZQVUxzRjhMa3BCS3FNeUFIZmM5Y2pYLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZHBVMmpybklUempOcDYxTVQ2UFVMc0Y4TGtwQktxTXlBSGZjOWNqWCxwPTJWQXJNWWFEUDF6V2dLUFBNQTc4YVBxWGFidnJuc3dCKzdacjErUEwxWmc9</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1naFZ6dmtJRkZpVEtCS2NsU0xMUQ==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1naFZ6dmtJRkZpVEtCS2NsU0xMUVZRUndFZGJlNzladzlNc1F2d0VILHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Z2hWenZrSUZGaVRLQktjbFNMTFFWUVJ3RWRiZTc5Wnc5TXNRdndFSCxwPWNlZlJmK2lIdjlPSTBPb3M2Q1gvYUdsdW1EeTRFZ2N5c2FYamtZR2NSR1k9</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1BQzdQRzJ3ZHlFNjNVYzVxODRXUA==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1BQzdQRzJ3ZHlFNjNVYzVxODRXUGs4WllwWlhSRExWU0NDMTFMQ2pNLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9QUM3UEcyd2R5RTYzVWM1cTg0V1BrOFpZcFpYUkRMVlNDQzExTENqTSxwPUxvcm9rQTRkTUp1WHBVR3RVZ2lZK2xtaUZFNVBWTVZlL0thQkc0SXFUbU09</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1sa2E1T3c2bU1iUVhEY201V3JOMA==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1sa2E1T3c2bU1iUVhEY201V3JOMGVrR1loYjUya04wYjVzV0JEc1NLLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9bGthNU93Nm1NYlFYRGNtNVdyTjBla0dZaGI1MmtOMGI1c1dCRHNTSyxwPWlraWNyTXk2MGNKcTR5bDJpN2R5V2tPM3hnSUlKVlpWNGUyUGp4RHBtRE09</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj13d2ZGVzJ3Sk5sOEpGRElkMVdRTA==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj13d2ZGVzJ3Sk5sOEpGRElkMVdRTEhXb3RLOXR3VFJGdFVsV09RZEZ5LHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9d3dmRlcyd0pObDhKRkRJZDFXUUxIV290Szl0d1RSRnRVbFdPUWRGeSxwPVMxdnhvcVNsQWhZSm1obnZ1UjFtdmRDYU5JMzBpaE9UZUhMRlRjQkg4OFU9</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1WemNDT1dDRENsTlVWZHJNRG11VA==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WemNDT1dDRENsTlVWZHJNRG11VDg4bVAxUWhmbDdWRWZaYUtiNjRZLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VnpjQ09XQ0RDbE5VVmRyTURtdVQ4OG1QMVFoZmw3VkVmWmFLYjY0WSxwPVQwakZTYktzMFI0bU5RbVU1eTRuNWcwYkZrRG1leDA2Z2hhRW1vSjBqanc9</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj03eVdYejdmV3RQb3hPRU1kc24yZA==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03eVdYejdmV3RQb3hPRU1kc24yZGgwYUc4VE1GVWl2NjI1MHJHM1dBLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3lXWHo3Zld0UG94T0VNZHNuMmRoMGFHOFRNRlVpdjYyNTByRzNXQSxwPThGcnEzRzVDS1RSbEJZYjBEMEx1NnFsRjEzbDM3K2JzNFNRM3k1d3doaFE9</response>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:50 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:50 | [Mutex] received everything.

2019-11-27 21:18:50 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:50 | [Mutex] waiting for: [event]

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:50 | user :: user_aikxqx0027@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-27 21:18:50 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj12T3NFM3RFTGptRHk1b0tnc3BZbg==</auth>

2019-11-27 21:18:50 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj12T3NFM3RFTGptRHk1b0tnc3BZbmJJSGpmNFdPQnJpZUpFUG9NRDRiLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9dk9zRTN0RUxqbUR5NW9LZ3NwWW5iSUhqZjRXT0JyaWVKRVBvTUQ0YixwPU8yVU84Mm8zWGdrN2lHbkNlVnIyMGFxQlAwK2NPY3pkekx5a215eUYvRVE9</response>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:51 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:51 | [Mutex] received everything.

2019-11-27 21:18:51 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:51 | [Mutex] waiting for: [event]

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1rNWYwMUNqZWNPYjJkdEY5akNGcw==</auth>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1rNWYwMUNqZWNPYjJkdEY5akNGc0w4Tkt1emNtdjlXUXFqc0dWRm1LLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9azVmMDFDamVjT2IyZHRGOWpDRnNMOE5LdXpjbXY5V1FxanNHVkZtSyxwPUFwVDBOU1pmSWpsWnRia0pLQjkyWjl4RHRPRnA5SS9vbm9FUGl3dmxtaFE9</response>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:51 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:51 | [Mutex] received everything.

2019-11-27 21:18:51 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:51 | [Mutex] waiting for: [event]

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1lMnBkR2RIT0k4aHhuclEyZnF6eQ==</auth>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1lMnBkR2RIT0k4aHhuclEyZnF6eUNxSjRodGU3dGJ1VDZCeDlXWDA1LHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZTJwZEdkSE9JOGh4bnJRMmZxenlDcUo0aHRlN3RidVQ2Qng5V1gwNSxwPUdtSGZnVVFLSStkZUNhK0xqc1NMd1FoN1k4b1A3SU0xNlJjOVhpQS9GcUU9</response>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:51 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:51 | [Mutex] received everything.

2019-11-27 21:18:51 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:51 | [Mutex] waiting for: [event]

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj1YSGZDd3NLTkt0SXlwUHRGdHpNRw==</auth>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1YSGZDd3NLTkt0SXlwUHRGdHpNR1RTdGVpU3gwUWlJaWFPdFBwUHRULHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9WEhmQ3dzS05LdEl5cFB0RnR6TUdUU3RlaVN4MFFpSWlhT3RQcFB0VCxwPTYrZ0tiVncrbmZBWTdlWmdncTZZaXFWT0VHRXZpVHYrVFJFT0xrRFVYWDQ9</response>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:51 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:51 | [Mutex] received everything.

2019-11-27 21:18:51 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:51 | user :: user_aikxqx0027@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-27 21:18:51 | user :: user_aikxqx0027@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2Fpa3hxeDAwMjcscj0xNTJtYW1obm04bDFrYzZDWm83cA==</auth>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0xNTJtYW1obm04bDFrYzZDWm83cHp0RHpBSElycFQ0b1JYZ3RLZVBMLHM9RzBBNFZpNk5JcGl6V2c9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MTUybWFtaG5tOGwxa2M2Q1pvN3B6dER6QUhJcnBUNG9SWGd0S2VQTCxwPXBiMy9PTCtPQUdlZ0pwblg4L1dJOTdhOEVwY1MzcVhEMnc0ZmlqK1ltcUk9</response>

2019-11-27 21:18:51 | user :: user_aikxqx0027@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><invalid-authzid/><text xml:lang="en">SCRAM: user_aikxqx0027@localhost is not authorized to act as user_aikxqx0027@localhost</text></failure>

2019-11-27 21:18:53 | [Mutex] waiting for: [user]

2019-11-27 21:18:53 | [Mutex] received everything.

2019-11-27 21:18:53 | [Mutex] isItemNotified: user:ok:false :: true

testOneInvalidLoginTooMuchDefaultSasl 3.528s
2019-11-27 21:18:53 |

2019-11-27 21:18:53 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 21:18:53 | ------------------------------------

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@519c3828

2019-11-27 21:18:53 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f5bdc6b}, 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@5b645358}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e66d650}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2e0bf0cc}, 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=Wed Nov 27 21:18:53 PST 2019}}}}

2019-11-27 21:18:53 | [Mutex] waiting for: [registration]

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2f32c9e2

2019-11-27 21:18:53 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f5bdc6b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@5b645358}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e66d650}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2e0bf0cc}, 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=Wed Nov 27 21:18:53 PST 2019}}}}

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@56b5b1cf

2019-11-27 21:18:53 | 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-27 21:18:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e49291f}

2019-11-27 21:18:53 | 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-27 21:18:53 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@fb52b8a

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@36f19e47

2019-11-27 21:18:53 | 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-27 21:18:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4db17a9f}

2019-11-27 21:18:53 | 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-27 21:18:53 | user :: null >> <iq to="localhost" id="nxCCCjZhWVkFOSRTTcP7xhQ" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 21:18:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@493c8ffc}

2019-11-27 21:18:53 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="nxCCCjZhWVkFOSRTTcP7xhQ"><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-27 21:18:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7a07b3e7}

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@5cc82e56

2019-11-27 21:18:53 | user :: null >> <iq to="localhost" id="x12iHzfUfXdDysVfAsgU2pY" type="set"><query xmlns="jabber:iq:register"><username>user_y9s4op0028</username><password>user_y9s4op0028</password><email>271828d6-6251-4754-89b9-94ec84b5ce3b@localhost</email></query></iq>

2019-11-27 21:18:53 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@7d78f435}

2019-11-27 21:18:53 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="x12iHzfUfXdDysVfAsgU2pY"/>

2019-11-27 21:18:53 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@66f1802e}

2019-11-27 21:18:53 | [Mutex] received everything.

2019-11-27 21:18:53 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 21:18:53 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e49291f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4db17a9f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f5bdc6b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@5b645358}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e66d650}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2e0bf0cc}, 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=Wed Nov 27 21:18:53 PST 2019}}}}

2019-11-27 21:18:53 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@7e49291f, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@4db17a9f]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@5f5bdc6b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@5b645358}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@1e66d650}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@2e0bf0cc}, 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=Wed Nov 27 21:18:53 PST 2019}}}}

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@20d26bed

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@670d7c9b

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@7aaa54b2

2019-11-27 21:18:53 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@10b05b39

2019-11-27 21:18:54 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@238ec7c1

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj16OWpvWmlkZmtGN3dUVkpqYmdhcA==</auth>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj16OWpvWmlkZmtGN3dUVkpqYmdhcHNrSWRONHNrRXB3RFFwSlVNaWNZLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ejlqb1ppZGZrRjd3VFZKamJnYXBza0lkTjRza0Vwd0RRcEpVTWljWSxwPTJZbnBnQWQwSXVuWGdBMDFQc3NraFBOb0poZFNnRVJEUjc4TEJ6VVFramM9</response>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj14M0lYODRFb05QZG0wbUZVaVd5bEdJZS9hYzc3UnFuTGFFR2RWc2V6cWdnPQ==</success>

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

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <iq xmlns="jabber:client" id="MQtgU2pYWTcMDDzw5Ej6s1d" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <iq xmlns="jabber:client" type="result" id="MQtgU2pYWTcMDDzw5Ej6s1d" to="user_y9s4op0028@localhost/993927746-tigase-20"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_y9s4op0028@localhost/993927746-tigase-20</jid></bind></iq>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 >> <iq xmlns="jabber:client" id="6ZS9LPR0mJROUaIEDqQHO05" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" type="result" id="6ZS9LPR0mJROUaIEDqQHO05" to="user_y9s4op0028@localhost/993927746-tigase-20"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 >> <iq to="localhost" id="jOjV001siFHHMBGneIxfBCF" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 << <enabled resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" id="5bd4326f-29d8-4e61-a858-26c8de62af6d"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 >> <iq id="FUzjUal5gOYkS5kEj2sZlZm" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 << <iq from="localhost" xmlns="jabber:client" type="result" id="jOjV001siFHHMBGneIxfBCF" to="user_y9s4op0028@localhost/993927746-tigase-20"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 21:18:54 | user :: user_y9s4op0028@localhost/993927746-tigase-20 << <iq xmlns="jabber:client" type="result" id="FUzjUal5gOYkS5kEj2sZlZm" to="user_y9s4op0028@localhost/993927746-tigase-20"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:54 | Disconnecting

2019-11-27 21:18:54 | [Mutex] notify: [disconnected]

2019-11-27 21:18:54 | [Mutex] received everything.

2019-11-27 21:18:54 | [Mutex] waiting for: [event]

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj1SUEFEa0hBd3FMTzdtZFl3ZzhRZA==</auth>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1SUEFEa0hBd3FMTzdtZFl3ZzhRZHBRZk5nTFRWUVFtN2JPZjVOdUxQLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UlBBRGtIQXdxTE83bWRZd2c4UWRwUWZOZ0xUVlFRbTdiT2Y1TnVMUCxwPVU5bGEySmNiSWRteXFOOStEK21ZWjBmMWNieGg3b3ZBZWpqQ21scDE1cTg9</response>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:54 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:54 | [Mutex] received everything.

2019-11-27 21:18:54 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:54 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:54 | [Mutex] waiting for: [event]

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj0yQnJPck13ckxwNG5DV0NzUVVVeQ==</auth>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yQnJPck13ckxwNG5DV0NzUVVVeXZvYzhOdzFBZVlZWk40eVM3Q1pYLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MkJyT3JNd3JMcDRuQ1dDc1FVVXl2b2M4TncxQWVZWVpONHlTN0NaWCxwPWRYTmVzSHB5Z0tRL3U1MU9ydTExK2RHQ054d1FPenhMQmhKZGxzcExoNGc9</response>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:54 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:54 | [Mutex] received everything.

2019-11-27 21:18:54 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:54 | [Mutex] waiting for: [event]

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj1vc0FjUjg2R3JIRVo1Q0w4ZXluRA==</auth>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1vc0FjUjg2R3JIRVo1Q0w4ZXluRENpR2pQSDBDcGRSSzB3Snh1cU9HLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9b3NBY1I4NkdySEVaNUNMOGV5bkRDaUdqUEgwQ3BkUkswd0p4dXFPRyxwPTJLZVFvRlpwdU9zczNzSW9NYnVyVmlWdUE4Yk54QjQ5Q0VEckpQQksvbUU9</response>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:54 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:54 | [Mutex] received everything.

2019-11-27 21:18:54 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:54 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:54 | [Mutex] waiting for: [event]

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:54 | user :: user_y9s4op0028@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-27 21:18:54 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj0yWVpoRGtQdDQ2UEZNdVA0bzVQUA==</auth>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0yWVpoRGtQdDQ2UEZNdVA0bzVQUHVuY3RsamhKYkM3cFUwejBqcVRhLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9MllaaERrUHQ0NlBGTXVQNG81UFB1bmN0bGpoSmJDN3BVMHowanFUYSxwPTZVTkRYRVNWSHA4RWpXRm4yZnVaS0d0UzUraWpxSTlYdXgxOUpBLzVIZG89</response>

2019-11-27 21:18:54 | user :: user_y9s4op0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:54 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:54 | [Mutex] notify: [event, disconnected]

2019-11-27 21:18:54 | [Mutex] received everything.

2019-11-27 21:18:54 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:55 | user :: user_y9s4op0028@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-27 21:18:55 | user :: user_y9s4op0028@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:55 | user :: user_y9s4op0028@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-27 21:18:55 | user :: user_y9s4op0028@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX3k5czRvcDAwMjgscj1kTzFhNWQ5aEE4M2tsSVhvc3hUSQ==</auth>

2019-11-27 21:18:55 | user :: user_y9s4op0028@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1kTzFhNWQ5aEE4M2tsSVhvc3hUSWVhNk95MDJXbVpJNGdIeFQ1R0NkLHM9VEZ3endGa3FjVFZtRXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:55 | user :: user_y9s4op0028@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9ZE8xYTVkOWhBODNrbElYb3N4VEllYTZPeTAyV21aSTRnSHhUNUdDZCxwPUx6Y3JMM1czSGN0dVVnZitrelhjL1dlN3dCeEZNUzNUQk1yMDkwLzhnQzQ9</response>

2019-11-27 21:18:55 | user :: user_y9s4op0028@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:57 | [Mutex] waiting for: [user]

2019-11-27 21:18:57 | [Mutex] received everything.

2019-11-27 21:18:57 | [Mutex] isItemNotified: user:ok:true :: true

testOneInvalidLoginTooMuchRandomSasl 3.109s
2019-11-27 21:18:57 |

2019-11-27 21:18:57 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 21:18:57 | ------------------------------------

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@ee68b27

2019-11-27 21:18:57 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21748b}, 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@41ee057}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@411c7eb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7b996a07}, 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=Wed Nov 27 21:18:57 PST 2019}}}}

2019-11-27 21:18:57 | [Mutex] waiting for: [registration]

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@7097dcd3

2019-11-27 21:18:57 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21748b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@41ee057}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@411c7eb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7b996a07}, 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=Wed Nov 27 21:18:57 PST 2019}}}}

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@3f896ce

2019-11-27 21:18:57 | 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-27 21:18:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@213381ff}

2019-11-27 21:18:57 | 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-27 21:18:57 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@11ca1e8c

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@5f752922

2019-11-27 21:18:57 | 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-27 21:18:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@18fc9ae4}

2019-11-27 21:18:57 | 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-27 21:18:57 | user :: null >> <iq to="localhost" id="LKZeO0eNKuZoapbFItqRcEp" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 21:18:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@6cfdfbac}

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@257ddc7d

2019-11-27 21:18:57 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="LKZeO0eNKuZoapbFItqRcEp"><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-27 21:18:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@64028820}

2019-11-27 21:18:57 | user :: null >> <iq to="localhost" id="HXAuZnQYiYaFuYXk29FDEla" type="set"><query xmlns="jabber:iq:register"><username>user_cqmcz0029</username><password>user_cqmcz0029</password><email>78f835ba-3957-438e-8567-8f2b78d84e7e@localhost</email></query></iq>

2019-11-27 21:18:57 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@f46840bd}

2019-11-27 21:18:57 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="HXAuZnQYiYaFuYXk29FDEla"/>

2019-11-27 21:18:57 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@124891bb}

2019-11-27 21:18:57 | [Mutex] received everything.

2019-11-27 21:18:57 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 21:18:57 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@213381ff, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@18fc9ae4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21748b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@41ee057}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@411c7eb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7b996a07}, 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=Wed Nov 27 21:18:57 PST 2019}}}}

2019-11-27 21:18:57 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@213381ff, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@18fc9ae4]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@21748b}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@41ee057}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@411c7eb0}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@7b996a07}, 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=Wed Nov 27 21:18:57 PST 2019}}}}

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6e9f12ac

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@254ab536

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@55f97a37

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@3eaec7a

2019-11-27 21:18:57 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@157694d9

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NxbWN6MDAyOSxyPVB0bTlQeW0wb2RsTkY0dlhRVHNs</auth>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1QdG05UHltMG9kbE5GNHZYUVRzbFdtQ3ZOWWpnbXJrRlVUTzd3MFdVLHM9ek1pM3ljM09YdlhoSXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9UHRtOVB5bTBvZGxORjR2WFFUc2xXbUN2TllqZ21ya0ZVVE83dzBXVSxwPXU0OUIwYjU5clhwVkhzVjFKWXBJWW1RNFk2bTllRURNL0NDeFM3cUZoV1U9</response>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj02QWdFemVjeXF4cWRYVW1PY0hyR2w5YWRDMS9YdVJ5TEdEbG9VMkZDMGtNPQ==</success>

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

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost >> <iq xmlns="jabber:client" id="zN4hFKVjV3o8hX0iWgKPOCf" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <iq xmlns="jabber:client" type="result" id="zN4hFKVjV3o8hX0iWgKPOCf" to="user_cqmcz0029@localhost/993927746-tigase-21"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_cqmcz0029@localhost/993927746-tigase-21</jid></bind></iq>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 >> <iq xmlns="jabber:client" id="WMZjVevuZsar3dQ7HHBukFJ" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" type="result" id="WMZjVevuZsar3dQ7HHBukFJ" to="user_cqmcz0029@localhost/993927746-tigase-21"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 >> <iq to="localhost" id="t6VRcpiQNLDGN3p1k01rYeO" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 >> <iq id="jXsdAal6AfR1qTgxymPPLWj" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 << <enabled resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" id="a772e499-6971-4e85-bb5f-585a276be94f"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 << <iq from="localhost" xmlns="jabber:client" type="result" id="t6VRcpiQNLDGN3p1k01rYeO" to="user_cqmcz0029@localhost/993927746-tigase-21"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 << <iq xmlns="jabber:client" type="result" id="jXsdAal6AfR1qTgxymPPLWj" to="user_cqmcz0029@localhost/993927746-tigase-21"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:18:57 | Disconnecting

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost/993927746-tigase-21 << <presence from="user_cqmcz0029@localhost/993927746-tigase-21" xmlns="jabber:client" to="user_cqmcz0029@localhost"><c node="http://tigase.org/jaxmpp" hash="sha-1" xmlns="http://jabber.org/protocol/caps" ver="mg5bXbOeu1848vxdgu3jELgbQF8="/></presence>

2019-11-27 21:18:57 | [Mutex] notify: [disconnected]

2019-11-27 21:18:57 | [Mutex] received everything.

2019-11-27 21:18:57 | [Mutex] waiting for: [event]

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-1">biwsbj11c2VyX2NxbWN6MDAyOSxyPUVKWm55V3FLTGtFZ0kwR1cyODho</auth>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1FSlpueVdxS0xrRWdJMEdXMjg4aHJLMWhNTlJrS01mcVNTekdlWXpSLHM9L2dCRllsMnBKb1A2RGc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9RUpabnlXcUtMa0VnSTBHVzI4OGhySzFoTU5Sa0tNZnFTU3pHZVl6UixwPXBweGpaVEk1WnRHZTROd0VoSGJpdG8zaFR2ND0=</response>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:57 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:57 | [Mutex] received everything.

2019-11-27 21:18:57 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:57 | [Mutex] waiting for: [event]

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NxbWN6MDAyOSxyPXNna1BBdG5pOG1HdWxFMm80NTdx</auth>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1zZ2tQQXRuaThtR3VsRTJvNDU3cUkwWnpUZVB2NnhHQVhKQ0ZINjVULHM9ek1pM3ljM09YdlhoSXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9c2drUEF0bmk4bUd1bEUybzQ1N3FJMFp6VGVQdjZ4R0FYSkNGSDY1VCxwPWxVNVlPTzF0TGUyV25PQTlFNlBBTW5hWnNGVXpZUktnditMNk4vWGRZRVk9</response>

2019-11-27 21:18:57 | user :: user_cqmcz0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:57 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:57 | [Mutex] received everything.

2019-11-27 21:18:57 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:57 | [Mutex] waiting for: [event]

2019-11-27 21:18:57 | user :: user_cqmcz0029@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-27 21:18:57 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:58 | user :: user_cqmcz0029@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-27 21:18:58 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NxbWN6MDAyOSxyPTd3WmxncDd3OExVbHUxVlZUbmhp</auth>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj03d1psZ3A3dzhMVWx1MVZWVG5oaUtOcEhNUndSMXdlcmJCUlhISWlOLHM9ek1pM3ljM09YdlhoSXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9N3dabGdwN3c4TFVsdTFWVlRuaGlLTnBITVJ3UjF3ZXJiQlJYSElpTixwPU5yWDRsUjB3bkZ0WVJXK2dtUEFRTnpwOWdhc2ZtN0JXaHBvZkpsL3Rmanc9</response>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:58 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:58 | [Mutex] received everything.

2019-11-27 21:18:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:58 | [Mutex] waiting for: [event]

2019-11-27 21:18:58 | user :: user_cqmcz0029@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-27 21:18:58 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:58 | user :: user_cqmcz0029@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-27 21:18:58 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="PLAIN">AHVzZXJfY3FtY3owMDI5ACAtIC0gLSAtIC0=</auth>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:18:58 | [Mutex] notify: [event, authFailed]

2019-11-27 21:18:58 | [Mutex] received everything.

2019-11-27 21:18:58 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:18:58 | user :: user_cqmcz0029@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-27 21:18:58 | user :: user_cqmcz0029@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:18:58 | user :: user_cqmcz0029@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-27 21:18:58 | user :: user_cqmcz0029@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyX2NxbWN6MDAyOSxyPUN0TVRLUEx1UjdKa2thSEZ1UGhj</auth>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1DdE1US1BMdVI3SmtrYUhGdVBoY0ZFU29vVmd3clRKQTNmeEE3TFI2LHM9ek1pM3ljM09YdlhoSXc9PSxpPTQwOTY=</challenge>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9Q3RNVEtQTHVSN0pra2FIRnVQaGNGRVNvb1Znd3JUSkEzZnhBN0xSNixwPVppRDRGNml4SnpCZVoyMkk4NjY1Tm16NUh5RFJablVwaGxjTGlWeWNUZm89</response>

2019-11-27 21:18:58 | user :: user_cqmcz0029@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:19:00 | [Mutex] waiting for: [user]

2019-11-27 21:19:00 | [Mutex] received everything.

2019-11-27 21:19:00 | [Mutex] isItemNotified: user:ok:true :: true

testThreeInvalidLogins 3.037s
2019-11-27 21:19:00 |

2019-11-27 21:19:00 | null / [TestClass name=class tigase.tests.server.TestBruteforcePrevention]

2019-11-27 21:19:00 | ------------------------------------

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@da9b36c

2019-11-27 21:19:00 | StateChangedEvent{oldState=null, newState=connecting, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@36e4ca9}, 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@751d81c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@42534692}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@221bf67}, 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=Wed Nov 27 21:19:00 PST 2019}}}}

2019-11-27 21:19:00 | [Mutex] waiting for: [registration]

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@73dba08e

2019-11-27 21:19:00 | StateChangedEvent{oldState=connecting, newState=connected, sessionObject=AbstractSessionObject{properties={TRUST_MANAGERS_KEY=Entry{scope=user, value=[Ljavax.net.ssl.X509TrustManager;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@36e4ca9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@751d81c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@42534692}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@221bf67}, 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=Wed Nov 27 21:19:00 PST 2019}}}}

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$ConnectedHandler$ConnectedEvent@7a4307d1

2019-11-27 21:19:00 | 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-27 21:19:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@227cb9dd}

2019-11-27 21:19:00 | 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-27 21:19:00 | user :: null >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xml.DefaultElement@25881ca3}

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$StreamRestartedHandler$StreamRestaredEvent@2d29e072

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$EncryptionEstablishedHandler$EncryptionEstablishedEvent@358fa89

2019-11-27 21:19:00 | 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-27 21:19:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@614708bc}

2019-11-27 21:19:00 | 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-27 21:19:00 | user :: null >> <iq to="localhost" id="iaZaFuYXk29FDElalaAhJzy" type="get"><query xmlns="jabber:iq:register"/></iq>

2019-11-27 21:19:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@86b34d52}

2019-11-27 21:19:00 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="iaZaFuYXk29FDElalaAhJzy"><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-27 21:19:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@2632e718}

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.xmpp.modules.registration.InBandRegistrationModule$ReceivedRequestedFieldsHandler$ReceivedRequestedFieldsEvent@44faa9dc

2019-11-27 21:19:00 | user :: null >> <iq to="localhost" id="XaXbKxy7IGt7l6DJLJKQHNG" type="set"><query xmlns="jabber:iq:register"><username>user_7iqxju0030</username><password>user_7iqxju0030</password><email>ec6af2e3-4ae2-4447-9936-5956341301b7@localhost</email></query></iq>

2019-11-27 21:19:00 | StanzaSendingEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@1430e0b}

2019-11-27 21:19:00 | user :: null << <iq from="localhost" xmlns="jabber:client" type="result" id="XaXbKxy7IGt7l6DJLJKQHNG"/>

2019-11-27 21:19:00 | StanzaReceivedEvent{stanza=tigase.jaxmpp.core.client.xmpp.stanzas.IQ@b29f78}

2019-11-27 21:19:00 | [Mutex] received everything.

2019-11-27 21:19:00 | [Mutex] isItemNotified: registrationSuccess :: true

2019-11-27 21:19:00 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@227cb9dd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@614708bc]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@36e4ca9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@751d81c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@42534692}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@221bf67}, 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=Wed Nov 27 21:19:00 PST 2019}}}}

2019-11-27 21:19:00 | 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;@3224720f}, CONNECTOR#DISABLEKEEPALIVE=Entry{scope=stream, value=false}, StreamFeaturesModule#STREAMS_FEATURES_LIST=Entry{scope=session, value=[tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@227cb9dd, tigase.jaxmpp.j2se.connectors.socket.SocketConnector$3@614708bc]}, STREAMS_MANAGER_KEY=Entry{scope=user, value=tigase.jaxmpp.core.client.xmpp.stream.XmppStreamsManager@36e4ca9}, COMPRESSION_DISABLED=Entry{scope=user, value=true}, HOSTNAME_VERIFIER_KEY=Entry{scope=session, value=tigase.jaxmpp.j2se.connectors.socket.DefaultHostnameVerifier@73197834}, 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@751d81c}, PresenceModule#PRESENCE_STORE=Entry{scope=user, value=tigase.jaxmpp.j2se.J2SEPresenceStore@42534692}, ResponseManager#RESPONSE_MANAGER=Entry{scope=user, value=tigase.jaxmpp.j2se.ThreadSafeResponseManager@221bf67}, 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=Wed Nov 27 21:19:00 PST 2019}}}}

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@59e9653a

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.JaxmppCore$LoggedOutHandler$LoggedOutEvent@68d25338

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.SessionObject$ClearedHandler$ClearedEvent@79f7b3b7

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$StreamTerminatedHandler$StreamTerminatedEvent@6daaaaae

2019-11-27 21:19:00 | tigase.jaxmpp.core.client.Connector$DisconnectedHandler$DisconnectedEvent@7ff8d294

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdpcXhqdTAwMzAscj1xdXdCc1Z3QlZvNFYzOUZBTEJrQw==</auth>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1xdXdCc1Z3QlZvNFYzOUZBTEJrQ2tKaFU5bDBtbW1YSUJBYXFkVWEyLHM9cnBIWHNjUVl3Z2gyblE9PSxpPTQwOTY=</challenge>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9cXV3QnNWd0JWbzRWMzlGQUxCa0NrSmhVOWwwbW1tWElCQWFxZFVhMixwPWRTcWp1UmM1QVVPS0VHajZZaWVWWUxpc1lUTHZmNUJ2RFdZa1lpRUlqWWc9</response>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj13aTM4MjdXVlYveWlnV1FqTWJnczZuNGhMUkpDUVErQ3J1OTlJelkxVjlJPQ==</success>

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

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost >> <iq xmlns="jabber:client" id="97MJKQHNGEEGAvakFKSP1l4" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <iq xmlns="jabber:client" type="result" id="97MJKQHNGEEGAvakFKSP1l4" to="user_7iqxju0030@localhost/993927746-tigase-22"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7iqxju0030@localhost/993927746-tigase-22</jid></bind></iq>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 >> <iq xmlns="jabber:client" id="wQViQNLDGN3p1k01rYeO0eN" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" type="result" id="wQViQNLDGN3p1k01rYeO0eN" to="user_7iqxju0030@localhost/993927746-tigase-22"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 >> <iq to="localhost" id="A1qVgXn3jUal5gOYkS5kEj2" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 << <enabled resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" id="ba004efd-b7c0-44a2-8940-52c0eab235f2"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 >> <iq id="if4kZ8gxumNXdOFODKKBnR8" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 << <iq from="localhost" xmlns="jabber:client" type="result" id="A1qVgXn3jUal5gOYkS5kEj2" to="user_7iqxju0030@localhost/993927746-tigase-22"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 21:19:00 | user :: user_7iqxju0030@localhost/993927746-tigase-22 << <iq xmlns="jabber:client" type="result" id="if4kZ8gxumNXdOFODKKBnR8" to="user_7iqxju0030@localhost/993927746-tigase-22"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:19:00 | Disconnecting

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

2019-11-27 21:19:00 | [Mutex] notify: [disconnected]

2019-11-27 21:19:00 | [Mutex] received everything.

2019-11-27 21:19:00 | [Mutex] waiting for: [event]

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdpcXhqdTAwMzAscj1WNVdHZDVnOGtGdTVVQVBqUklvcg==</auth>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1WNVdHZDVnOGtGdTVVQVBqUklvcnN1YnhoVmxXSjVkZkZoTmFvRlNkLHM9cnBIWHNjUVl3Z2gyblE9PSxpPTQwOTY=</challenge>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9VjVXR2Q1ZzhrRnU1VUFQalJJb3JzdWJ4aFZsV0o1ZGZGaE5hb0ZTZCxwPWJNL1QzRDFWZzBQVjNYZVBGdE1kMmJ2c2hCTW9KbERQU0hISWRMelR5Q2s9</response>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:19:00 | [Mutex] notify: [event, authFailed]

2019-11-27 21:19:00 | [Mutex] received everything.

2019-11-27 21:19:00 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:19:00 | [Mutex] waiting for: [event]

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:00 | user :: user_7iqxju0030@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-27 21:19:00 | user :: user_7iqxju0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdpcXhqdTAwMzAscj0zdnF5NEp1eFk5ekhWRkRUdnhjbg==</auth>

2019-11-27 21:19:00 | user :: user_7iqxju0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj0zdnF5NEp1eFk5ekhWRkRUdnhjbnIyTG9NWTlKbmVETkMybm9vczJ1LHM9cnBIWHNjUVl3Z2gyblE9PSxpPTQwOTY=</challenge>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9M3ZxeTRKdXhZOXpIVkZEVHZ4Y25yMkxvTVk5Sm5lRE5DMm5vb3MydSxwPVZDM2RDVWNGbkd4S2dkemNSSGhEb29KSERWdEM0SHZlU0ViNllnWnVGWE09</response>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:19:01 | [Mutex] notify: [event, authFailed]

2019-11-27 21:19:01 | [Mutex] received everything.

2019-11-27 21:19:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:19:01 | [Mutex] waiting for: [event]

2019-11-27 21:19:01 | user :: user_7iqxju0030@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-27 21:19:01 | user :: user_7iqxju0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:01 | user :: user_7iqxju0030@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-27 21:19:01 | user :: user_7iqxju0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdpcXhqdTAwMzAscj1XWmpBT2o5cldmTzZmWlBrbktKTQ==</auth>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1XWmpBT2o5cldmTzZmWlBrbktKTTFiRk82QWNPUFZRN0pIbklIalNrLHM9cnBIWHNjUVl3Z2gyblE9PSxpPTQwOTY=</challenge>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9V1pqQU9qOXJXZk82ZlpQa25LSk0xYkZPNkFjT1BWUTdKSG5JSGpTayxwPXkxdDB2c3U4bTdYbVZuOUpFTXJwOUdqMzQ1KzBhOUhpSk5DYVZMMmN4VFk9</response>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <failure xmlns="urn:ietf:params:xml:ns:xmpp-sasl"><not-authorized/><text xml:lang="en">Password not verified</text></failure>

2019-11-27 21:19:01 | [Mutex] notify: [event, authFailed]

2019-11-27 21:19:01 | [Mutex] received everything.

2019-11-27 21:19:01 | [Mutex] isItemNotified: authFailed :: true

2019-11-27 21:19:01 | user :: user_7iqxju0030@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-27 21:19:01 | user :: user_7iqxju0030@localhost >> <starttls xmlns="urn:ietf:params:xml:ns:xmpp-tls"/>

2019-11-27 21:19:01 | user :: user_7iqxju0030@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-27 21:19:01 | user :: user_7iqxju0030@localhost >> <auth xmlns="urn:ietf:params:xml:ns:xmpp-sasl" mechanism="SCRAM-SHA-256">biwsbj11c2VyXzdpcXhqdTAwMzAscj1OVUdiaFlSdU5rQ1JBV215aDZwVA==</auth>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <challenge xmlns="urn:ietf:params:xml:ns:xmpp-sasl">cj1OVUdiaFlSdU5rQ1JBV215aDZwVDZIcDZRQktkallqNnF5ajdReFJuLHM9cnBIWHNjUVl3Z2gyblE9PSxpPTQwOTY=</challenge>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost >> <response xmlns="urn:ietf:params:xml:ns:xmpp-sasl">Yz1iaXdzLHI9TlVHYmhZUnVOa0NSQVdteWg2cFQ2SHA2UUJLZGpZajZxeWo3UXhSbixwPWRwKzZaM0RLQWUwTXFJY0VVLzNEeVBOVnFVazB6MlNDd0IrWHRvUTRPdUU9</response>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <success xmlns="urn:ietf:params:xml:ns:xmpp-sasl">dj1PM2FVODR6bjVXZkJiOGdMc0gxMlFYMCs5eTMrclk5WFBSeWVSaWYzbUY0PQ==</success>

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

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost >> <iq xmlns="jabber:client" id="pg5dNTanetq6jNHO3zr5sgx" type="set"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><resource/></bind></iq>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost << <iq xmlns="jabber:client" type="result" id="pg5dNTanetq6jNHO3zr5sgx" to="user_7iqxju0030@localhost/993927746-tigase-23"><bind xmlns="urn:ietf:params:xml:ns:xmpp-bind"><jid>user_7iqxju0030@localhost/993927746-tigase-23</jid></bind></iq>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 >> <iq xmlns="jabber:client" id="vnoL0gDrZodT5n2qR7kWeQU" type="set"><session xmlns="urn:ietf:params:xml:ns:xmpp-session"/></iq>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" type="result" id="vnoL0gDrZodT5n2qR7kWeQU" to="user_7iqxju0030@localhost/993927746-tigase-23"/>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 >> <iq to="localhost" id="SUXTcMDDzw5Ej6s1dxuphRV" type="get"><query xmlns="http://jabber.org/protocol/disco#info"/></iq>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 >> <enable xmlns="urn:xmpp:sm:3" resume="true"/>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 << <enabled resume="true" xmlns="urn:xmpp:sm:3" location="d4270859fb27" max="60" id="fa3b45dc-bcd3-40d7-97cb-c832c75d99d8"/>

2019-11-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 >> <iq id="CleRbFxm49HugS8ujMy7EGr" type="get"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:19:01 | user :: user_7iqxju0030@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-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 << <iq from="localhost" xmlns="jabber:client" type="result" id="SUXTcMDDzw5Ej6s1dxuphRV" to="user_7iqxju0030@localhost/993927746-tigase-23"><query xmlns="http://jabber.org/protocol/disco#info"><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="component" type="router"/><identity name="Tigase ver. 8.1.0-SNAPSHOT-b10581/f55efd39" category="server" 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="jabber:iq:auth"/><feature var="vcard-temp"/><feature var="http://jabber.org/protocol/amp"/><feature var="msgoffline"/><feature var="http://jabber.org/protocol/disco#info"/><feature var="http://jabber.org/protocol/disco#items"/><feature var="urn:xmpp:blocking"/><feature var="urn:xmpp:ping"/><feature var="urn:ietf:params:xml:ns:xmpp-sasl"/><feature var="http://jabber.org/protocol/pubsub"/><feature var="http://jabber.org/protocol/pubsub#owner"/><feature var="http://jabber.org/protocol/pubsub#publish"/><identity category="pubsub" type="pep"/><feature var="urn:xmpp:pep-vcard-conversion:0"/><feature var="urn:xmpp:bookmarks-conversion:0"/><feature var="urn:xmpp:archive:auto"/><feature var="urn:xmpp:archive:manage"/><feature var="urn:xmpp:push:0"/><feature var="tigase:push:away:0"/><feature var="tigase:push:encrypt:0"/><feature var="tigase:push: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-27 21:19:01 | user :: user_7iqxju0030@localhost/993927746-tigase-23 << <iq xmlns="jabber:client" type="result" id="CleRbFxm49HugS8ujMy7EGr" to="user_7iqxju0030@localhost/993927746-tigase-23"><query xmlns="jabber:iq:roster"/></iq>

2019-11-27 21:19:01 | Disconnecting

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

2019-11-27 21:19:01 | [Mutex] notify: [disconnected]

2019-11-27 21:19:01 | [Mutex] received everything.

2019-11-27 21:19:03 | [Mutex] waiting for: [user]

2019-11-27 21:19:03 | [Mutex] received everything.

2019-11-27 21:19:03 | [Mutex] isItemNotified: user:ok:true :: true